builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1454766573.64 results: success (0) buildid: 20160206031736 builduid: 676273b8e8d14481ad405868ee66f8bf revision: c58d59c815ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.636498) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.637026) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.637350) ========= 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006359 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.660666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.660992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.674382) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.674807) ========= 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 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 -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.724669) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.725057) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.725475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.725750) ========= 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 05:49:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.0M=0s 2016-02-06 05:49:35 (57.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.954395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:33.954716) ========= 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019602 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.003993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.004352) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c58d59c815ea --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c58d59c815ea --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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 05:49:35,135 Setting DEBUG logging. 2016-02-06 05:49:35,136 attempt 1/10 2016-02-06 05:49:35,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c58d59c815ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 05:49:35,385 unpacking tar archive at: mozilla-beta-c58d59c815ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525919 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.545759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.546158) ========= echo c58d59c815ea in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c58d59c815ea'] 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c58d59c815ea program finished with exit code 0 elapsedTime=0.004029 script_repo_revision: 'c58d59c815ea' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.597793) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.598107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 05:49:34.607866) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-06 05:49:34.608200) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:35 INFO - MultiFileLogger online at 20160206 05:49:35 in /builds/slave/test-pgo 05:49:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:49:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:49:35 INFO - {'append_to_log': False, 05:49:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:49:35 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:49:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:49:35 INFO - 'branch': 'Mozilla-Beta', 05:49:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:35 INFO - 'config_files': ('talos/linux_config.py',), 05:49:35 INFO - 'default_actions': ('clobber', 05:49:35 INFO - 'read-buildbot-config', 05:49:35 INFO - 'download-and-extract', 05:49:35 INFO - 'populate-webroot', 05:49:35 INFO - 'create-virtualenv', 05:49:35 INFO - 'install', 05:49:35 INFO - 'run-tests'), 05:49:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:35 INFO - 'download_minidump_stackwalk': True, 05:49:35 INFO - 'download_symbols': 'ondemand', 05:49:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:35 INFO - 'installer_path': 'installer.exe', 05:49:35 INFO - 'log_level': 'info', 05:49:35 INFO - 'log_name': 'talos', 05:49:35 INFO - 'log_to_console': True, 05:49:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:35 INFO - 'opt_config_files': (), 05:49:35 INFO - 'pip_index': False, 05:49:35 INFO - 'sps_profile': False, 05:49:35 INFO - 'sps_profile_interval': 0, 05:49:35 INFO - 'suite': 'dromaeojs', 05:49:35 INFO - 'system_bits': '32', 05:49:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:35 INFO - 'title': 'talos-linux64-ix-034', 05:49:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:35 INFO - 'use_talos_json': True, 05:49:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:49:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:35 INFO - 'work_dir': 'build'} 05:49:35 INFO - ##### 05:49:35 INFO - ##### Running clobber step. 05:49:35 INFO - ##### 05:49:35 INFO - Running pre-action listener: _resource_record_pre_action 05:49:35 INFO - Running main action method: clobber 05:49:35 INFO - rmtree: /builds/slave/test-pgo/build 05:49:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:49:36 INFO - Running post-action listener: _resource_record_post_action 05:49:36 INFO - ##### 05:49:36 INFO - ##### Running read-buildbot-config step. 05:49:36 INFO - ##### 05:49:36 INFO - Running pre-action listener: _resource_record_pre_action 05:49:36 INFO - Running main action method: read_buildbot_config 05:49:36 INFO - Using buildbot properties: 05:49:36 INFO - { 05:49:36 INFO - "properties": { 05:49:36 INFO - "buildnumber": 69, 05:49:36 INFO - "product": "firefox", 05:49:36 INFO - "script_repo_revision": "production", 05:49:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:49:36 INFO - "repository": "", 05:49:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:49:36 INFO - "buildid": "20160206031736", 05:49:36 INFO - "slavename": "talos-linux64-ix-034", 05:49:36 INFO - "pgo_build": "True", 05:49:36 INFO - "basedir": "/builds/slave/test-pgo", 05:49:36 INFO - "project": "", 05:49:36 INFO - "platform": "ubuntu64_hw", 05:49:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:49:36 INFO - "slavebuilddir": "test", 05:49:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:49:36 INFO - "branch": "mozilla-beta", 05:49:36 INFO - "repo_path": "releases/mozilla-beta", 05:49:36 INFO - "stage_platform": "linux64-pgo", 05:49:36 INFO - "builduid": "676273b8e8d14481ad405868ee66f8bf", 05:49:36 INFO - "revision": "c58d59c815ea" 05:49:36 INFO - }, 05:49:36 INFO - "sourcestamp": { 05:49:36 INFO - "repository": "", 05:49:36 INFO - "hasPatch": false, 05:49:36 INFO - "project": "", 05:49:36 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:49:36 INFO - "changes": [ 05:49:36 INFO - { 05:49:36 INFO - "category": null, 05:49:36 INFO - "files": [ 05:49:36 INFO - { 05:49:36 INFO - "url": null, 05:49:36 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2" 05:49:36 INFO - } 05:49:36 INFO - ], 05:49:36 INFO - "repository": "", 05:49:36 INFO - "rev": "c58d59c815ea", 05:49:36 INFO - "who": "sendchange", 05:49:36 INFO - "when": 1454766489, 05:49:36 INFO - "number": 7574402, 05:49:36 INFO - "comments": "No bug, Automated blocklist update from host bld-linux64-spot-234 - a=blocklist-update", 05:49:36 INFO - "project": "", 05:49:36 INFO - "at": "Sat 06 Feb 2016 05:48:09", 05:49:36 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 05:49:36 INFO - "revlink": "", 05:49:36 INFO - "properties": [ 05:49:36 INFO - [ 05:49:36 INFO - "buildid", 05:49:36 INFO - "20160206031736", 05:49:36 INFO - "Change" 05:49:36 INFO - ], 05:49:36 INFO - [ 05:49:36 INFO - "builduid", 05:49:36 INFO - "676273b8e8d14481ad405868ee66f8bf", 05:49:36 INFO - "Change" 05:49:36 INFO - ], 05:49:36 INFO - [ 05:49:36 INFO - "pgo_build", 05:49:36 INFO - "True", 05:49:36 INFO - "Change" 05:49:36 INFO - ] 05:49:36 INFO - ], 05:49:36 INFO - "revision": "c58d59c815ea" 05:49:36 INFO - } 05:49:36 INFO - ], 05:49:36 INFO - "revision": "c58d59c815ea" 05:49:36 INFO - } 05:49:36 INFO - } 05:49:36 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2. 05:49:36 INFO - Running post-action listener: _resource_record_post_action 05:49:36 INFO - ##### 05:49:36 INFO - ##### Running download-and-extract step. 05:49:36 INFO - ##### 05:49:36 INFO - Running pre-action listener: _resource_record_pre_action 05:49:36 INFO - Running main action method: download_and_extract 05:49:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/test_packages.json 05:49:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:49:36 INFO - Downloaded 1270 bytes. 05:49:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:49:36 INFO - Using the following test package requirements: 05:49:36 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:49:36 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:36 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'jsshell-linux-x86_64.zip'], 05:49:36 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:36 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:49:36 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 05:49:36 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 05:49:36 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:36 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 05:49:36 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 05:49:36 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:36 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:49:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:37 INFO - Downloaded 21581646 bytes. 05:49:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:49:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:49:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:49:38 INFO - Return code: 0 05:49:38 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:49:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:38 INFO - Downloaded 21581646 bytes. 05:49:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 05:49:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:49:40 INFO - Return code: 0 05:49: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')]} 05:49:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:49:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:40 INFO - Downloaded 11132038 bytes. 05:49:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:49:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 05:49:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:49:40 INFO - Return code: 0 05:49: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')]} 05:49:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:49:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:41 INFO - Downloaded 57947206 bytes. 05:49:41 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:49:41 INFO - mkdir: /builds/slave/test-pgo/properties 05:49:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:49:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:49:41 INFO - Contents: 05:49:41 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2 05:49:41 INFO - Running post-action listener: _resource_record_post_action 05:49:41 INFO - Running post-action listener: set_extra_try_arguments 05:49:41 INFO - ##### 05:49:41 INFO - ##### Running populate-webroot step. 05:49:41 INFO - ##### 05:49:41 INFO - Running pre-action listener: _resource_record_pre_action 05:49:41 INFO - Running main action method: populate_webroot 05:49:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:41 INFO - '--tppagecycles', 05:49:41 INFO - '7'], 05:49:41 INFO - 'tests': ['tsvgm']}}, 05:49:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:49:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:49:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:49:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'tests': ['damp', 'tps']}, 05:49:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['damp', 'tps']}, 05:49:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:49:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:41 INFO - 'other': {'tests': ['a11yr', 05:49:41 INFO - 'ts_paint', 05:49:41 INFO - 'tpaint', 05:49:41 INFO - 'sessionrestore', 05:49:41 INFO - 'sessionrestore_no_auto_restore']}, 05:49:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['a11yr', 05:49:41 INFO - 'ts_paint', 05:49:41 INFO - 'tpaint', 05:49:41 INFO - 'sessionrestore', 05:49:41 INFO - 'sessionrestore_no_auto_restore']}, 05:49:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['a11yr', 05:49:41 INFO - 'ts_paint', 05:49:41 INFO - 'tpaint', 05:49:41 INFO - 'sessionrestore', 05:49:41 INFO - 'sessionrestore_no_auto_restore']}, 05:49:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['a11yr', 05:49:41 INFO - 'ts_paint', 05:49:41 INFO - 'tpaint', 05:49:41 INFO - 'sessionrestore', 05:49:41 INFO - 'sessionrestore_no_auto_restore']}, 05:49:41 INFO - 'other_l64': {'tests': ['a11yr', 05:49:41 INFO - 'ts_paint', 05:49:41 INFO - 'tpaint', 05:49:41 INFO - 'sessionrestore', 05:49:41 INFO - 'sessionrestore_no_auto_restore']}, 05:49:41 INFO - 'other_nol64': {'tests': ['a11yr', 05:49:41 INFO - 'ts_paint', 05:49:41 INFO - 'tpaint', 05:49:41 INFO - 'sessionrestore', 05:49:41 INFO - 'sessionrestore_no_auto_restore']}, 05:49:41 INFO - 'svgr': {'tests': ['tsvgx', 05:49:41 INFO - 'tsvgr_opacity', 05:49:41 INFO - 'tart', 05:49:41 INFO - 'tscrollx', 05:49:41 INFO - 'cart']}, 05:49:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['tsvgx', 05:49:41 INFO - 'tsvgr_opacity', 05:49:41 INFO - 'tart', 05:49:41 INFO - 'tscrollx', 05:49:41 INFO - 'cart']}, 05:49:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'tests': ['tp5o']}, 05:49:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'talos_options': ['--e10s'], 05:49:41 INFO - 'tests': ['tp5o']}, 05:49:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'talos_options': ['--xperf_path', 05:49:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:41 INFO - 'tests': ['tp5n']}, 05:49:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:41 INFO - 'talos_options': ['--e10s', 05:49:41 INFO - '--xperf_path', 05:49:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:41 INFO - 'tests': ['tp5n']}}, 05:49:41 INFO - 'talos.zip': {'path': '', 05:49:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:41 INFO - Running post-action listener: _resource_record_post_action 05:49:41 INFO - ##### 05:49:41 INFO - ##### Running create-virtualenv step. 05:49:41 INFO - ##### 05:49:41 INFO - Running pre-action listener: _resource_record_pre_action 05:49:41 INFO - Running main action method: create_virtualenv 05:49:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:49:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:49:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:49:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:41 INFO - Using real prefix '/usr' 05:49:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:49:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:43 INFO - Installing pip.................done. 05:49:44 INFO - Return code: 0 05:49:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:49:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:44 INFO - Using env: {'DISPLAY': ':0', 05:49:44 INFO - 'HOME': '/home/cltbld', 05:49:44 INFO - 'LANG': 'en_US.UTF-8', 05:49:44 INFO - 'LANGUAGE': 'en_US:en', 05:49:44 INFO - 'LOGNAME': 'cltbld', 05:49:44 INFO - 'MAIL': '/var/mail/cltbld', 05:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:44 INFO - 'MOZ_NO_REMOTE': '1', 05:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:44 INFO - 'NO_EM_RESTART': '1', 05:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:44 INFO - 'SHELL': '/bin/bash', 05:49:44 INFO - 'SHLVL': '1', 05:49:44 INFO - 'TERM': 'linux', 05:49:44 INFO - 'TMOUT': '86400', 05:49:44 INFO - 'USER': 'cltbld', 05:49:44 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:44 INFO - '_': '/tools/buildbot/bin/python'} 05:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:44 INFO - Cleaning up... 05:49:44 INFO - Return code: 0 05:49:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:49:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:49:44 INFO - Using env: {'DISPLAY': ':0', 05:49:44 INFO - 'HOME': '/home/cltbld', 05:49:44 INFO - 'LANG': 'en_US.UTF-8', 05:49:44 INFO - 'LANGUAGE': 'en_US:en', 05:49:44 INFO - 'LOGNAME': 'cltbld', 05:49:44 INFO - 'MAIL': '/var/mail/cltbld', 05:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:44 INFO - 'MOZ_NO_REMOTE': '1', 05:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:44 INFO - 'NO_EM_RESTART': '1', 05:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:44 INFO - 'SHELL': '/bin/bash', 05:49:44 INFO - 'SHLVL': '1', 05:49:44 INFO - 'TERM': 'linux', 05:49:44 INFO - 'TMOUT': '86400', 05:49:44 INFO - 'USER': 'cltbld', 05:49:44 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:44 INFO - '_': '/tools/buildbot/bin/python'} 05:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:44 INFO - Downloading/unpacking psutil>=0.7.1 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:46 INFO - Installing collected packages: psutil 05:49:46 INFO - Running setup.py install for psutil 05:49:46 INFO - building 'psutil._psutil_linux' extension 05:49:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:46 INFO - building 'psutil._psutil_posix' extension 05:49:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:49:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:46 INFO - Successfully installed psutil 05:49:46 INFO - Cleaning up... 05:49:46 INFO - Return code: 0 05:49:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:49:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:49:46 INFO - Using env: {'DISPLAY': ':0', 05:49:46 INFO - 'HOME': '/home/cltbld', 05:49:46 INFO - 'LANG': 'en_US.UTF-8', 05:49:46 INFO - 'LANGUAGE': 'en_US:en', 05:49:46 INFO - 'LOGNAME': 'cltbld', 05:49:46 INFO - 'MAIL': '/var/mail/cltbld', 05:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:46 INFO - 'MOZ_NO_REMOTE': '1', 05:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:46 INFO - 'NO_EM_RESTART': '1', 05:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:46 INFO - 'SHELL': '/bin/bash', 05:49:46 INFO - 'SHLVL': '1', 05:49:46 INFO - 'TERM': 'linux', 05:49:46 INFO - 'TMOUT': '86400', 05:49:46 INFO - 'USER': 'cltbld', 05:49:46 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:46 INFO - '_': '/tools/buildbot/bin/python'} 05:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:49:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:49:48 INFO - Installing collected packages: mozsystemmonitor 05:49:48 INFO - Running setup.py install for mozsystemmonitor 05:49:48 INFO - Successfully installed mozsystemmonitor 05:49:48 INFO - Cleaning up... 05:49:49 INFO - Return code: 0 05:49:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:49: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')]} 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:49:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:49:49 INFO - Using env: {'DISPLAY': ':0', 05:49:49 INFO - 'HOME': '/home/cltbld', 05:49:49 INFO - 'LANG': 'en_US.UTF-8', 05:49:49 INFO - 'LANGUAGE': 'en_US:en', 05:49:49 INFO - 'LOGNAME': 'cltbld', 05:49:49 INFO - 'MAIL': '/var/mail/cltbld', 05:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:49 INFO - 'MOZ_NO_REMOTE': '1', 05:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:49 INFO - 'NO_EM_RESTART': '1', 05:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:49 INFO - 'SHELL': '/bin/bash', 05:49:49 INFO - 'SHLVL': '1', 05:49:49 INFO - 'TERM': 'linux', 05:49:49 INFO - 'TMOUT': '86400', 05:49:49 INFO - 'USER': 'cltbld', 05:49:49 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:49 INFO - '_': '/tools/buildbot/bin/python'} 05:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:49:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - Downloading docopt-0.6.1.tar.gz 05:49:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:51 INFO - Running setup.py install for blobuploader 05:49:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:49:51 INFO - Running setup.py install for requests 05:49:52 INFO - Running setup.py install for docopt 05:49:52 INFO - Successfully installed blobuploader requests docopt 05:49:52 INFO - Cleaning up... 05:49:52 INFO - Return code: 0 05:49:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:49:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:52 INFO - Using env: {'DISPLAY': ':0', 05:49:52 INFO - 'HOME': '/home/cltbld', 05:49:52 INFO - 'LANG': 'en_US.UTF-8', 05:49:52 INFO - 'LANGUAGE': 'en_US:en', 05:49:52 INFO - 'LOGNAME': 'cltbld', 05:49:52 INFO - 'MAIL': '/var/mail/cltbld', 05:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:52 INFO - 'MOZ_NO_REMOTE': '1', 05:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:52 INFO - 'NO_EM_RESTART': '1', 05:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:52 INFO - 'SHELL': '/bin/bash', 05:49:52 INFO - 'SHLVL': '1', 05:49:52 INFO - 'TERM': 'linux', 05:49:52 INFO - 'TMOUT': '86400', 05:49:52 INFO - 'USER': 'cltbld', 05:49:52 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:52 INFO - '_': '/tools/buildbot/bin/python'} 05:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:49:52 INFO - Running setup.py (path:/tmp/pip-mK9yXr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:49:52 INFO - Running setup.py (path:/tmp/pip-9XOHlN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:49:52 INFO - Running setup.py (path:/tmp/pip-6bQ5xe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:49:52 INFO - Running setup.py (path:/tmp/pip-wQrWH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:49:52 INFO - Running setup.py (path:/tmp/pip-3o_KlC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:49:52 INFO - Running setup.py (path:/tmp/pip-V7oncr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:49:53 INFO - Running setup.py (path:/tmp/pip-_h2tpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:49:53 INFO - Running setup.py (path:/tmp/pip-iGzD_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:49:53 INFO - Running setup.py (path:/tmp/pip-kXhdV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:49:53 INFO - Running setup.py (path:/tmp/pip-2TJ2Qm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:49:53 INFO - Running setup.py (path:/tmp/pip-Mj0pKy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:49:53 INFO - Running setup.py (path:/tmp/pip-1Y935u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:49:53 INFO - Running setup.py (path:/tmp/pip-fF_0bU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:49:53 INFO - Running setup.py (path:/tmp/pip-XCpyrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:49:53 INFO - Running setup.py (path:/tmp/pip-KZcMCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:49:53 INFO - Running setup.py (path:/tmp/pip-PY036U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:49:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:49:53 INFO - Running setup.py (path:/tmp/pip-fWlJMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:49:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:53 INFO - Running setup.py install for manifestparser 05:49:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:49:53 INFO - Running setup.py install for mozcrash 05:49:53 INFO - Running setup.py install for mozdebug 05:49:54 INFO - Running setup.py install for mozdevice 05:49:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Running setup.py install for mozfile 05:49:54 INFO - Running setup.py install for mozhttpd 05:49:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Running setup.py install for mozinfo 05:49:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Running setup.py install for mozInstall 05:49:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Running setup.py install for mozleak 05:49:54 INFO - Running setup.py install for mozlog 05:49:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Running setup.py install for moznetwork 05:49:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:49:54 INFO - Running setup.py install for mozprocess 05:49:55 INFO - Running setup.py install for mozprofile 05:49:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:49:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:49:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:49:55 INFO - Running setup.py install for mozrunner 05:49:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:49:55 INFO - Running setup.py install for mozscreenshot 05:49:55 INFO - Running setup.py install for moztest 05:49:55 INFO - Running setup.py install for mozversion 05:49:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:49:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:55 INFO - Cleaning up... 05:49:55 INFO - Return code: 0 05:49:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:49:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:55 INFO - Using env: {'DISPLAY': ':0', 05:49:55 INFO - 'HOME': '/home/cltbld', 05:49:55 INFO - 'LANG': 'en_US.UTF-8', 05:49:55 INFO - 'LANGUAGE': 'en_US:en', 05:49:55 INFO - 'LOGNAME': 'cltbld', 05:49:55 INFO - 'MAIL': '/var/mail/cltbld', 05:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:55 INFO - 'MOZ_NO_REMOTE': '1', 05:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:55 INFO - 'NO_EM_RESTART': '1', 05:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:55 INFO - 'SHELL': '/bin/bash', 05:49:55 INFO - 'SHLVL': '1', 05:49:55 INFO - 'TERM': 'linux', 05:49:55 INFO - 'TMOUT': '86400', 05:49:55 INFO - 'USER': 'cltbld', 05:49:55 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:55 INFO - '_': '/tools/buildbot/bin/python'} 05:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:49:55 INFO - Running setup.py (path:/tmp/pip-YMxAgl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:49:55 INFO - Running setup.py (path:/tmp/pip-Hp8C0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:49:55 INFO - Running setup.py (path:/tmp/pip-Z64WHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:49:56 INFO - Running setup.py (path:/tmp/pip-T4vUXA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:49:56 INFO - Running setup.py (path:/tmp/pip-Hb473A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:49:56 INFO - Running setup.py (path:/tmp/pip-Zl1EiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:49:56 INFO - Running setup.py (path:/tmp/pip-1FMpjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:49:56 INFO - Running setup.py (path:/tmp/pip-vTJdnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:49:56 INFO - Running setup.py (path:/tmp/pip-vBVXTG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:49:56 INFO - Running setup.py (path:/tmp/pip-Jekfss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:49:56 INFO - Running setup.py (path:/tmp/pip-exrZgV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:49:56 INFO - Running setup.py (path:/tmp/pip-ut4nLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:49:56 INFO - Running setup.py (path:/tmp/pip-clW796-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:49:56 INFO - Running setup.py (path:/tmp/pip-Bv2g3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:49:56 INFO - Running setup.py (path:/tmp/pip-QWzmfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:49:56 INFO - Running setup.py (path:/tmp/pip-mAa4kS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:49:56 INFO - Running setup.py (path:/tmp/pip-ppDT0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:58 INFO - Downloading blessings-1.6.tar.gz 05:49:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:58 INFO - Installing collected packages: blessings 05:49:58 INFO - Running setup.py install for blessings 05:49:58 INFO - Successfully installed blessings 05:49:58 INFO - Cleaning up... 05:49:59 INFO - Return code: 0 05:49:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:49:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:49:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:49:59 INFO - Reading from file tmpfile_stdout 05:49:59 INFO - Current package versions: 05:49:59 INFO - argparse == 1.2.1 05:49:59 INFO - blessings == 1.6 05:49:59 INFO - blobuploader == 1.2.4 05:49:59 INFO - docopt == 0.6.1 05:49:59 INFO - manifestparser == 1.1 05:49:59 INFO - mozInstall == 1.12 05:49:59 INFO - mozcrash == 0.16 05:49:59 INFO - mozdebug == 0.1 05:49:59 INFO - mozdevice == 0.47 05:49:59 INFO - mozfile == 1.2 05:49:59 INFO - mozhttpd == 0.7 05:49:59 INFO - mozinfo == 0.9 05:49:59 INFO - mozleak == 0.1 05:49:59 INFO - mozlog == 3.1 05:49:59 INFO - moznetwork == 0.27 05:49:59 INFO - mozprocess == 0.22 05:49:59 INFO - mozprofile == 0.27 05:49:59 INFO - mozrunner == 6.11 05:49:59 INFO - mozscreenshot == 0.1 05:49:59 INFO - mozsystemmonitor == 0.0 05:49:59 INFO - moztest == 0.7 05:49:59 INFO - mozversion == 1.4 05:49:59 INFO - psutil == 3.1.1 05:49:59 INFO - requests == 1.2.3 05:49:59 INFO - wsgiref == 0.1.2 05:49:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:49: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')]} 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:49:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:59 INFO - Using env: {'DISPLAY': ':0', 05:49:59 INFO - 'HOME': '/home/cltbld', 05:49:59 INFO - 'LANG': 'en_US.UTF-8', 05:49:59 INFO - 'LANGUAGE': 'en_US:en', 05:49:59 INFO - 'LOGNAME': 'cltbld', 05:49:59 INFO - 'MAIL': '/var/mail/cltbld', 05:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:59 INFO - 'MOZ_NO_REMOTE': '1', 05:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:59 INFO - 'NO_EM_RESTART': '1', 05:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:59 INFO - 'SHELL': '/bin/bash', 05:49:59 INFO - 'SHLVL': '1', 05:49:59 INFO - 'TERM': 'linux', 05:49:59 INFO - 'TMOUT': '86400', 05:49:59 INFO - 'USER': 'cltbld', 05:49:59 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:59 INFO - '_': '/tools/buildbot/bin/python'} 05:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:49:59 INFO - Cleaning up... 05:49:59 INFO - Return code: 0 05:49:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:49: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')]} 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:49:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:49:59 INFO - Using env: {'DISPLAY': ':0', 05:49:59 INFO - 'HOME': '/home/cltbld', 05:49:59 INFO - 'LANG': 'en_US.UTF-8', 05:49:59 INFO - 'LANGUAGE': 'en_US:en', 05:49:59 INFO - 'LOGNAME': 'cltbld', 05:49:59 INFO - 'MAIL': '/var/mail/cltbld', 05:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:59 INFO - 'MOZ_NO_REMOTE': '1', 05:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:59 INFO - 'NO_EM_RESTART': '1', 05:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:49:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:49:59 INFO - 'SHELL': '/bin/bash', 05:49:59 INFO - 'SHLVL': '1', 05:49:59 INFO - 'TERM': 'linux', 05:49:59 INFO - 'TMOUT': '86400', 05:49:59 INFO - 'USER': 'cltbld', 05:49:59 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:59 INFO - '_': '/tools/buildbot/bin/python'} 05:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:59 INFO - Downloading/unpacking jsonschema 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:50:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:01 INFO - warning: no files found matching '*.txt' 05:50:01 INFO - no previously-included directories found matching 'build' 05:50:01 INFO - no previously-included directories found matching 'dist' 05:50:01 INFO - no previously-included directories found matching '.git*' 05:50:01 INFO - Installing collected packages: jsonschema, functools32 05:50:01 INFO - Running setup.py install for functools32 05:50:01 INFO - warning: no files found matching '*.txt' 05:50:01 INFO - no previously-included directories found matching 'build' 05:50:01 INFO - no previously-included directories found matching 'dist' 05:50:01 INFO - no previously-included directories found matching '.git*' 05:50:01 INFO - Successfully installed jsonschema functools32 05:50:01 INFO - Cleaning up... 05:50:01 INFO - Return code: 0 05:50:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff75d367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, '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': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test-pgo/build 05:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 flake8 05:50:01 INFO - Using env: {'DISPLAY': ':0', 05:50:01 INFO - 'HOME': '/home/cltbld', 05:50:01 INFO - 'LANG': 'en_US.UTF-8', 05:50:01 INFO - 'LANGUAGE': 'en_US:en', 05:50:01 INFO - 'LOGNAME': 'cltbld', 05:50:01 INFO - 'MAIL': '/var/mail/cltbld', 05:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:01 INFO - 'MOZ_NO_REMOTE': '1', 05:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:01 INFO - 'NO_EM_RESTART': '1', 05:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:01 INFO - 'SHELL': '/bin/bash', 05:50:01 INFO - 'SHLVL': '1', 05:50:01 INFO - 'TERM': 'linux', 05:50:01 INFO - 'TMOUT': '86400', 05:50:01 INFO - 'USER': 'cltbld', 05:50:01 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:01 INFO - '_': '/tools/buildbot/bin/python'} 05:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:02 INFO - Downloading/unpacking flake8 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:50:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:50:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:04 INFO - no previously-included directories found matching 'docs/_build' 05:50:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:50:04 INFO - Running setup.py install for pep8 05:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:04 INFO - no previously-included directories found matching 'docs/_build' 05:50:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:50:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:50:04 INFO - Cleaning up... 05:50:04 INFO - Return code: 0 05:50:04 INFO - Running post-action listener: _resource_record_post_action 05:50:04 INFO - Running post-action listener: _start_resource_monitoring 05:50:04 INFO - Starting resource monitoring. 05:50:04 INFO - ##### 05:50:04 INFO - ##### Running install step. 05:50:04 INFO - ##### 05:50:04 INFO - Running pre-action listener: _resource_record_pre_action 05:50:04 INFO - Running main action method: install 05:50:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:50:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:50:05 INFO - Reading from file tmpfile_stdout 05:50:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:50:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:50:05 INFO - Reading from file tmpfile_stdout 05:50:05 INFO - Output received: 05:50:05 INFO - Usage: mozinstall [options] installer 05:50:05 INFO - Options: 05:50:05 INFO - -h, --help show this help message and exit 05:50:05 INFO - -d DEST, --destination=DEST 05:50:05 INFO - Directory to install application into. [default: 05:50:05 INFO - "/builds/slave/test-pgo"] 05:50:05 INFO - --app=APP Application being installed. [default: firefox] 05:50:05 INFO - mkdir: /builds/slave/test-pgo/build/application 05:50:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:50:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:50:19 INFO - Reading from file tmpfile_stdout 05:50:19 INFO - Output received: 05:50:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:50:19 INFO - Running post-action listener: _resource_record_post_action 05:50:19 INFO - ##### 05:50:19 INFO - ##### Running run-tests step. 05:50:19 INFO - ##### 05:50:19 INFO - Running pre-action listener: _resource_record_pre_action 05:50:19 INFO - Running main action method: run_tests 05:50:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:50:19 INFO - Python 2.7.3 05:50:19 INFO - Return code: 0 05:50:19 INFO - grabbing minidump binary from tooltool 05:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:19 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 0x116b350>, '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 0x116c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116c6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:50:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:50:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:50:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:19 INFO - Return code: 0 05:50:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:50:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:50:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:50:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:50:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:50:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:50:20 INFO - Return code: 0 05:50:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:50:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost 05:50:20 INFO - Using env: {'DISPLAY': ':0', 05:50:20 INFO - 'HOME': '/home/cltbld', 05:50:20 INFO - 'LANG': 'en_US.UTF-8', 05:50:20 INFO - 'LANGUAGE': 'en_US:en', 05:50:20 INFO - 'LOGNAME': 'cltbld', 05:50:20 INFO - 'MAIL': '/var/mail/cltbld', 05:50:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:50:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:20 INFO - 'MOZ_NO_REMOTE': '1', 05:50:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:20 INFO - 'NO_EM_RESTART': '1', 05:50:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:50:20 INFO - 'SHELL': '/bin/bash', 05:50:20 INFO - 'SHLVL': '1', 05:50:20 INFO - 'TERM': 'linux', 05:50:20 INFO - 'TMOUT': '86400', 05:50:20 INFO - 'USER': 'cltbld', 05:50:20 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259', 05:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:20 INFO - '_': '/tools/buildbot/bin/python'} 05:50:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost'] with output_timeout 3600 05:50:21 INFO - mozversion INFO | application_buildid: 20160206031736 05:50:21 INFO - mozversion INFO | application_changeset: c58d59c815ea2a276484119b54251f7019eabbf5 05:50:21 INFO - mozversion INFO | application_display_name: Nightly 05:50:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:21 INFO - mozversion INFO | application_name: Firefox 05:50:21 INFO - mozversion INFO | application_remotingname: firefox 05:50:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:50:21 INFO - mozversion INFO | application_vendor: Mozilla 05:50:21 INFO - mozversion INFO | application_version: 45.0 05:50:21 INFO - mozversion INFO | platform_buildid: 20160206031736 05:50:21 INFO - mozversion INFO | platform_changeset: c58d59c815ea2a276484119b54251f7019eabbf5 05:50:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:50:21 INFO - mozversion INFO | platform_version: 45.0 05:50:21 INFO - 2016-02-06 05:50:21,092 DEBUG : using testdate: 1454766621 05:50:21 INFO - 2016-02-06 05:50:21,092 DEBUG : actual date: 1454766621 05:50:21 INFO - 2016-02-06 05:50:21,100 INFO : starting webserver on 'localhost:43258' 05:50:21 INFO - 2016-02-06 05:50:21,101 INFO : Starting test suite talos-linux64-ix-034 05:50:21 INFO - 2016-02-06 05:50:21,101 INFO : Starting test dromaeo_css 05:50:21 INFO - 2016-02-06 05:50:21,101 DEBUG : operating with platform_type : linux_ 05:50:21 INFO - 2016-02-06 05:50:21,102 INFO : Initialising browser for dromaeo_css test... 05:50:21 INFO - 2016-02-06 05:50:21,116 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwnB0XB/profile http://localhost:43258/getInfo.html 05:50:24 INFO - 2016-02-06 05:50:24,917 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:50:24 INFO - 2016-02-06 05:50:24,917 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:50:24 INFO - 2016-02-06 05:50:24,917 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:50:24 INFO - 2016-02-06 05:50:24,917 DEBUG : BROWSER_OUTPUT: __metrics 05:50:25 INFO - 2016-02-06 05:50:25,078 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:26 INFO - 2016-02-06 05:50:26,036 INFO : Browser initialized. 05:50:26 INFO - 2016-02-06 05:50:26,037 INFO : Running cycle 1/1 for dromaeo_css test... 05:50:26 INFO - 2016-02-06 05:50:26,037 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwnB0XB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:50:37 INFO - 2016-02-06 05:50:37,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 134619136 05:50:37 INFO - 2016-02-06 05:50:37,794 DEBUG : BROWSER_OUTPUT: 05:51:28 INFO - 2016-02-06 05:51:28,671 DEBUG : BROWSER_OUTPUT: 1454766688666 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:53:37 INFO - 2016-02-06 05:53:37,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43258/tests/dromaeo/cssquery-ext.html) 05:53:38 INFO - 2016-02-06 05:53:38,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 223264768 05:53:38 INFO - 2016-02-06 05:53:38,308 DEBUG : BROWSER_OUTPUT: 05:56:40 INFO - 2016-02-06 05:56:40,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/dromaeo/cssquery-ext.html (next: http://localhost:43258/tests/dromaeo/cssquery-jquery.html) 05:56:40 INFO - 2016-02-06 05:56:40,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 212234240 05:56:40 INFO - 2016-02-06 05:56:40,895 DEBUG : BROWSER_OUTPUT: 05:59:42 INFO - 2016-02-06 05:59:42,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43258/tests/dromaeo/cssquery-mootools.html) 05:59:43 INFO - 2016-02-06 05:59:43,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 206053376 05:59:43 INFO - 2016-02-06 05:59:43,201 DEBUG : BROWSER_OUTPUT: 06:02:44 INFO - 2016-02-06 06:02:44,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43258/tests/dromaeo/cssquery-prototype.html) 06:02:45 INFO - 2016-02-06 06:02:45,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 207962112 06:02:45 INFO - 2016-02-06 06:02:45,475 DEBUG : BROWSER_OUTPUT: 06:05:47 INFO - 2016-02-06 06:05:47,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43258/tests/dromaeo/cssquery-yui.html) 06:05:48 INFO - 2016-02-06 06:05:48,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 202113024 06:05:48 INFO - 2016-02-06 06:05:48,363 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/dromaeo/cssquery-yui.html (next: http://localhost:43258/tests/dromaeo/cssquery-dojo.html) 06:08:50 INFO - 2016-02-06 06:08:50,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 243363840 06:08:50 INFO - 2016-02-06 06:08:50,732 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:08:50 INFO - 2016-02-06 06:08:50,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:08:50 INFO - 2016-02-06 06:08:50,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:08:50 INFO - 2016-02-06 06:08:50,732 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:08:50 INFO - 2016-02-06 06:08:50,736 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3251.7561182911286;3367.2255381262294;3400.9659903400957;3403.9829800850994;3432.124808173916;5608.887822243552;5642.294713160855;5653.293338332708;5674.60277780555;5682.516986056185;5682.744276507557;5689.9146512802345;5695.914561281584;5707.429257074301;5710;4908.8281910133155;5134.409542902558;5173.275741396207;5239.21411788231;5251.474852514737;5008.4240312364;5123.666961647481;5141.5886729061585;5143.794248230066;5147.48525147486;5096.210087436453;5156.53591176794;5173.430922598511;5177.352830896138;5185.403678576974;5104.566111880495;5120.1039818031695;5147.819826306099;5151.922721159186;5163.586913046966;4952.826651067231;4966.602671786249;5038.39539255288;5054.772535235887;5069.087564238435;5393.946060539383;5425.294711687456;5435.211894275348;5436.103042997901;5437.918431223496;5989.5507836911975;6028.457438830483;6052.818415447544;6061.181740465025;6065.302490213594;5859.6191247569195;5971.253593300838;6013.36859629737;6114.663693496856;6125.908111378333;5674;5692.8861422771315;5697.202391665171;5701.572382071278;5707.1153971134545;6126.632402055891;6138.877222455615;6141.355157708376;6151.415615516519;6153.8307721532765;5795.652260864277;5888.646681199056;5917.171595976567;5955.52355811534;6074.271087469444;6039.1545183674325;6047.123167140828;6052.12244224585;6052.6671033092725;6060;5975.910361344583;5984.3417224105315;6010.2186715726675;6017.1275165100815;6024.487918526975;5673.8297851064535;5851.707414629252;5887.4701276884425;5989.131575921554;6012.699365031731;4594.1271158479785;4595.954040459619;4598.425196850327;4600.35595016698;4619.722816631013;4130.463039804867;4136.544980052192;4142.5857414258935;4145.854895078658;4160.396742472324;5469;5562.694051827189;5608.158776183605;5648.85877853057;5661.46216109469;6094.512439004869;6122.571420000646;6122.908156377658;6124.6325220486915;6125.785597504155;5697.658140511582;5704.1443783432815;5712.2288491054005;5718.228039214736;5719.370869204384;5052.141136006888;5173.482651734872;5204.063268611686;5269.420363759983;5312.787488500494;6249.6875156242;6251.156093927352;6255.124282600348;6259.248890133122;6264.467520260829;6069.635821850703;6120.418560236771;6129.509639228761;6131.938680613315;6134.141220229082;5897.764089436546;6000.8799824004145;6122.672617327995;6256.562040657111;6257.155284036597;5998.100284957117;6041.426064523863;6046.222354902177;6048.334683184934;6078.209832721895;5891.1457838612305;6125.816225513242;6151.630902145886;6152.415520525543;6154.661493617894;5797.594168408171;5810.448007439287;5946.108083787466;5954.07711804671;5963.254593175853;5893.675847828411;5934.169216309634;5936.436038576328;5939.910901336397;5942.910856337245;5651.15232715096;5680.460356266148;5832.270966129234;5845.766169353178;5850.151727999331;5853.0635098384055;5882.499266180025;5927.8221653350465;5929.881402372014;5943.673097979653;5787.479126878601;5866.120081987736;5873.03094989322;5876.588638795243;5880.059190529495 06:08:50 INFO - 2016-02-06 06:08:50,736 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.3688816078635;624.3350831364594;625.3871206217909;629.6977450823605;640.4876099120702;33255;39641.40537891934;39665;39748;40254.597454025454;43065.56934430655;43544.564554354445;43551.346729799;43661.345079823746;43718;8059.95970020152;8207.58962051898;8939.508327042011;9117.133872282122;9184.770380740501;10278.486075696223;10349.534270957787;10428.426436545988;10458.4770761462;10460.267781255316;10501.894981050207;10637.202209834293;10653.573857045747;10655.200859935498;10660.360378377283;10493.737656558571;10533.631322903662;10551.78896422071;10556.208284378703;10593.205509586773;10395.740106497322;10545.420001899893;10552.366857988469;10567.524461399256;10567.94716026415;41732.58267417317;42007.57992420098;42031.78984105091;42059.7897010516;42151.1569768606;3239.740820734359;3355.328934213167;3624.3657359961903;3728.5525736911472;3934;31193.532097018335;31519.684803151904;31560.684393156003;31606.683933160835;33988.66011339904;4257.489101307832;4337.132573485315;4355.673324500675;4382.496012958519;4404.4054052702795;276153;278016;278656;279192;279735;61393.386066138766;61411.38588614146;61786.382136178065;61944.69027654833;63325.36674633287;57453.13820292699;58133.709331453916;58169.709151454816;72076;72957.27042729611;15097.698046039017;15137.545873623809;15248.847511524742;15251;15281.46514871974;11598.88401115995;11625.88374116265;11643.41782910851;11653.941730291293;11677.88322116785;21453.463663408227;21824.127034918427;21854.89072554627;21881.234156804436;21893.124275028822;7693.461457698019;8065.459380295189;8081.393895457864;8222.794430139294;8256;945.7021038372891;1008.0423597582326;1009.4801177393648;1023.1150055202345;1107.2692023264606;33851.322973540395;34072;34339.4849077264;34496.655033449846;34793.478097828556;1048.2400259811727;1049.270756824;1061.7398737309254;1063.829787234042;1113.9665810025713;14640.633984150481;15491.612709682122;15840.52478425626;17274.827251727573;17354.479365619052;395641;403863;404908;404978;405522;55340;55431.168532472046;55667;55863.44136558582;56200.15699764507;1404.501402002295;1411.647088227943;1425.9928700356431;1428.5857101440465;1435.7056803355288;30895;30915.845420772752;31063.534046989764;31485;31732.524012139376;47676.523234767206;48113;50979.490205098955;51248.74375628098;51497.7425112872;298231;299656;302847;305017;305937;44303.77848110739;44689.882752930134;44904.32643510415;44925.77537112294;45679.77160114178;48001;48216.5178348226;48416;49368.50631493639;49581.25628115509;40319.18563664701;41240.1751964953;41551.7922410386;41617.37573936454;41952;41064.58935410727;43454.78272608617;44326;45303.320450192616;45470.54529454663;39589.60410395859;39723.2055358897;39937.003149842974;43889.78055109704;44550.10899781921;34612.307753845285;35125.824370879;38512.42231366588;39332.80333598314;40610.59389406068;26186.73813261843;26920.461590768467;27021.59467607948;27029.59455608128;27039.45921081607 06:08:50 INFO - 2016-02-06 06:08:50,740 DEBUG : BROWSER_OUTPUT: |2;jquery.html;373.43797584635126;375.4612131591167;375.6975634614136;377.9716521260904;378.86739641125627;15280.388784448636;16671.249793759278;16832.831671683278;18336.174872130752;19030.33393831216;16399.754003689955;16420.83579164208;16656.16719164043;16690.499285021437;16770.83229167708;3889.572147063821;5060.240963855433;5183.041137389576;5191.091558977183;5191.740412979355;3985.4619626350363;5543.972280138593;5731.656100633954;5732.48407643312;5734.827955161351;5648.6893220872835;5669.036263835158;5707.771689132451;5709.628874123168;6163.383661633823;6068.605540639866;6101.389861013885;6102.20671312731;6113.908291375633;6114.1745864308195;5298.97350513245;5402.513773760341;5407.702576358338;5418.458154184589;5489.066858634002;20221.595568088556;20350.694739578918;20681.58636827255;21577.67633485499;21747.782522174733;2291.4958709083976;2397.688300520921;2461.59383701689;2493.351728550572;2509.5482813093636;9756.90243097567;9818.165455936254;9907.851382229272;9989.850152247722;10169;1927.7012063130237;1998.15078591598;2004.2484068474323;2016.647086759826;2023.7875023122508;63450.36549634491;65400;65853.67073164604;66191.338086619;66811;10040.397576145455;10211.183105351554;10278.845817312746;10292.125169360688;10338.328008679411;13419.329033548283;13432.261225632488;13444.932775336061;13458.125221860548;13459;7310.744123955636;7332.816679583053;7334.303241192185;7388.187299397062;7396.593187374746;7019.684114214872;7062.117235345582;7076.823079423056;7116.359527642537;7152.821179470451;4106.425100485934;4289.356596510486;4309.827606895689;4413.293872980308;4716.858494245178;1722.6210233748554;1736.7047601907707;1795.6678014567347;1822.4988128264567;1844.2162081115473;845.7589586967684;928.7817362919709;932.2262522106636;1002.5739060899089;1009.3237530854345;14230.359633816503;15848.841511584737;16042.679146417006;16755.2460139294;17601;938.3478482454628;1001.0640051551823;1025.702546261576;1027.5376080763685;1047.3087762076993;9466.90533094674;9835.655752048644;10064.949675251723;10311.278210525192;10366.844497332546;632914;633993;641401;642400;647901;84373.57813210895;87555;88406;89825;91996;1138.6868611132004;1154.2209008918946;1157.3403160198775;1159.4087015622094;1170.3504554972071;16105.919470403041;16225.18874056316;16231.269592868113;16252.837471625133;16612.335506579602;36973.26053478861;37352;37545.62454375421;37780.43329350007;38725.41911871268;48276.758616206695;50455;51332;52271.21593176181;53876;9823.459709715748;10069.446180460145;10093;10152.79694406093;10229.232807539613;12120.575779847662;12178.512859485521;12195.146339756131;12299.385030748606;13829.446822127002;14635.41458341697;14734.557963261119;15333.846661533242;15378.154201519024;15605;12569.93715031419;12825.294608796607;14604.780928285873;14869.107853528823;15316.081035137928;15382.461613843461;15432.9228353862;15567.844321557093;15758.369665213722;15767.921160394124;10044.648437304659;10232.64185753495;10265.332753371007;10326.896731032593;10483.108935740547;10457.68626941193;11754.588589399329;14786.926065370035;14817.110973341634;15022 06:08:50 INFO - 2016-02-06 06:08:50,741 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1498.5204734484962;1513.6972605478904;1683.730603103503;1772.663193993142;1824.7901491328494;7847.489913155641;8277.213664701843;8280.420370574062;8307.543085130315;8323.33413326934;7498.887516687254;7615;7997.560134192631;8285.95857020714;8487.066422693515;2311.653252012195;2333.4166458385403;2345.495718420539;2349.5418393413293;2358.8466749661216;2111.7360329958756;2427.186892391051;2455.3002394317623;2464.581021226396;2471.369800700819;2144.4531644430726;2340.9063637454483;2421.539907417585;2422.515496900618;2422.5518279118332;2372.2408829174583;2372.9169479068237;2373.988130059356;2424.260600516842;2424.806015518754;2397.5924092904247;2411.46947671512;2424.9272521824373;2425.126954296452;2450.509898020385;8386.454880432751;8408.873866892001;8458;8458.661653533913;8468;4918.7786549605;5065.4174769901565;5065.442801291855;5068.543831055223;5069.493050694938;3271.7873338233176;3296.670332966708;3340.4154273002127;3363.1760218746563;3371.780834245766;1123.0459001337695;1146.1633007904277;1151.7293436042523;1163.2671417007316;1201.1651901928165;11883.108766842435;11899.345535995517;11903.64289071338;11928.284302941764;11948.820767688492;4489.618382437529;4494.662900282492;4503.437070366204;4528.796204170821;4549.727016378962;10029.348092373972;10048.145907597936;10051.798964020825;10061.647842325483;10066.496675166212;5054.620903432184;5087.3386459759995;5094;5104.03023425548;5109.770060347293;4629.537046295343;4641.3734145889875;4643.396358473445;4645.558671926162;4646.303054541846;3909.706771992112;3939.054626889526;3977.3320928010708;3980.4228386883738;4007.699422543321;1165.6736113888126;1177.7291223018753;1219.6341097670663;1264.165650670553;1279.833621629201;1052.768390953989;1079.0180935348794;1086.7391825961713;1247.7067889046066;1372.9862701373058;7868.527888326718;7895.684172633145;7947;7952.403569732293;7983.960080199562;1124.798081401679;1138.2885696439726;1140;1144.2733863996257;1160.5183848702864;5647.068233741469;5689.402612725604;5703.686297253608;5704.71476426177;5708.372079071299;9897.257705672104;10077;10282.742931426774;10304.072633462874;10402.531886065146;10213.182945364353;10222.080012798884;10229.74425639365;10232.59069637206;10238.897611023795;7712.383009359238;7897.210278972172;7976.641051152712;7984.960075199587;8013.038435387674;7519.887201691869;7649.349805266615;7685.308322251024;7686.231376862269;7692.538447693157;8991.550422478718;8993.910060899307;9067.954660226656;9178.67874624385;9212.078792120734;9334.766630834283;9347.205487533636;9355.578998944928;9494.810103798023;9598.760030999281;7481.625918704151;7555.886661700189;7556.433267505069;7565.546067235983;7571.545707257582;8165.755027349189;8183.918160818554;8186.959065204635;8190.262876341158;8247.051589067334;6796.456283497408;7727.42044346665;7781.144074151725;7794.688212471665;7870.331021863206;7042.260562640849;7602.049743782028;7663.080430348394;7742.961285193538;7821.374290056896;6963.93036069653;7003.789886303419;7008.404285635778;7009.649517524205;7010.334018268256;6725.327467253235;6725.798226053226;6749.595024298558;6757.662116894234;6793.252742198453;6834.658267086526;6864.519483636297;6865.725370985305;6870.931290687029;6871.175458944958 06:08:50 INFO - 2016-02-06 06:08:50,742 DEBUG : BROWSER_OUTPUT: |4;prototype.html;358.79190069759534;363.26257696875354;366.38630294257115;366.8165917041479;368.1679404545728;6117.6941152942345;6145.600535965159;6166.876662466748;6180.042093475518;6188.721507532161;5816.069428891378;5944.821655350335;5976.970115149429;6092.177556029935;6102.664353460558;4723.220668589687;4729.1251118543005;4729.2433210686295;4735.881602959937;4744.97627511862;4717.080169366975;4730.408698912636;4733.928991065137;4743.051389722053;4744.122337367598;4514.571115743999;4560.33875088112;4601.33280674302;4654.208784506642;4700.858974230779;4642.97678511607;4651.418572678415;4678.836240731558;4689.155951928651;4693.06138772247;4131.5455299916985;4134.462519872397;4139.461869956916;4141.233871733709;4154.189932963073;5783.21926539916;5787.913181302241;5792.88414231713;5796.13058041293;5796.681182534959;5377.193420986844;5492.862678433031;5497.285352904097;5497.505224529771;5497.532709719679;6451.161349024596;6456.7740129095255;6457.225132984072;6458.095866578683;6464.030395440722;4585.72485650862;4586.610138138262;4587.7706114694465;4588.128255631419;4596.885077873047;6554.606723596552;6668.666566671647;6681.76613818514;6683.598984060972;6684.665766711645;4705.12955103307;4705.55297246761;4715.599174070242;4717.669763116549;4722.362481065081;4765.11845308619;4768.165571025057;4768.690035147704;4779.115863565252;4787.952120478821;5454.12733962572;5458.808941687022;5463.2078348639225;5471.23402723619;5479.75341109651;6326.841828954221;6471.7734879279;6530.575512591667;6539.574927629689;6564.048213009182;1659.8506134447957;1680.1935071165665;1682.7812384389952;1683.6127690631224;1685.1068933465283;1123.966281011571;1124.8931351521592;1128.6783266768932;1137.556353022322;1149;6321;6324.588901721373;6333.36666333363;6334.398232167937;6337.302896681362;6750.291219421988;6751.966240168767;6756.932430675631;6758.3917447428985;6762.594244345355;6112.358202388774;6224.37756224383;6265.248170219603;6320.810375688737;6377.107204991305;3646.653567911097;3662.7436079474182;3686.705063594906;3690.0774806298427;3690.2619476104887;6954.3393377629045;6959.478039147084;6975.546589471668;6975.616341101187;6976.790696279119;6735.966320168466;6905.516613837083;6922.757703480454;6938.548994315353;6960.199577048705;6919.792406227721;6975.197852247056;6983.092198014328;6991.89512157318;6994.510384273154;6804.387605115563;6809.693563789542;6810.284920083518;6813.591184528944;6832.248452670103;6512.902306465501;6697.397234248941;6728.360805723449;6744.325567443217;6745.25802161752;6940.583564986117;6971.407430368476;6975;6978.68595913175;6984.161900571964;4701.224297990793;4739.834105806281;4740.407449068866;4741.596964257938;4747.810087596596;6681.231658359156;6795.1845778506895;6801.591904485746;6806.455483561204;6808.727650894107;6630.469562434897;6637.800865974028;6638.50211234169;6638.966805165944;6648.401643852077;6504.1219435375615;6613.867722645617;6625.602463852184;6629.105070815571;6635.170603674541;6486.708098135501;6507.251666058464;6512.120863683342;6520.641364724986;6523.054157147092;6572.441342485751;6613.834654133685;6633.800985970429;6635.469162467088;6640;6365.649889256136;6471.126397936218;6489.448396886129;6497.480201583768;6501.44737697301 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: |5;yui.html;825.4098319701415;884.1114679746853;892.9732108036761;901.6168128545366;906.8685040669098;12995.2202867828;13262.13796103255;13278.136921100122;13285.667858303535;13305.667358316035;12769.297688627123;12848.871511284884;12919.547815826449;12945.870541294584;12975.221486710803;739.8668239716849;750.3134631811913;857.0700789643245;860.1914200651368;875.3959767760225;870.6647940542905;877.0002197494829;877.368294827723;877.4384393987852;878.0999475537561;782.6360742254878;922.8154369126169;927.332320729074;928.6563971330584;929.1637526226416;779.228563721914;886.8669699545087;898.4564338575166;899.5861903524386;901.1709227510706;669.6082791566939;669.9363560461749;670.0184230102874;670.4401824476568;670.8121725916702;12038.458269377812;12110.15228933975;12114.273143611323;12129.5148194073;12323.69190770229;12014.519419223221;12281.877181228163;12506.437210325466;12517.186382885084;13002.219866808022;10356.637517686844;10521.894781052168;10710.732231694192;10731.409772462512;10780.15883712457;3729.850805967758;3828.425736139601;3833.1375440525658;3833.750806197588;3843.8846834595006;49394.75302623464;49589.25616115725;50557;51222.48777512214;51307.74346128246;8566.657333706706;8613.784655383666;8637.309015278763;8638.17937295956;8716.389852710376;16225.59436014109;16235.107069111313;16265.430709925096;16286.429974950819;16290.755638665429;7274.27257274279;7742.535447873146;7774.727884524014;7813.570253636105;7977.401694872908;4170.270202714573;4205.3271476563605;4328.372386004012;4378.43080399546;4387.758673272937;3209.6148462184688;3221.935561288761;3241.967580324214;3255.169931667457;3266.7223286020953;557.3840905799115;572.2559977784206;581.0209796492923;583.775246530089;587.5182350472656;526.541908539573;626.8526896179394;648.060312546809;648.7515995595654;666.7297850817972;8541.95729021351;8961.910380896108;9063.456192628464;9368.718938431857;9710.320277580642;531.5588061908684;582.7727186397309;668.2582333609689;685.2530741491798;715.8174665460274;4049.7570145791346;4104.91790164195;4268.2530557152995;4344.500382455994;4361.214981303396;60476;61348.69325653343;61508;62728.68635656792;62829.68585157045;49895.75052124716;50074.499255007715;50254.49745502498;50412.49587504078;53675.73162134243;49228.26157607639;49539.25691114636;49624.75187624111;49649.255261171114;49961.50038499641;8475.618597163266;8623.310135189295;8798.12018798115;8807.471551706662;8828.293736500937;36312.4553131698;36794.26411471702;37367.43948840715;37915.81042094772;38273.61726382701;44014;48533.27200092072;49249.50750492449;49524.25713614371;49583.504164957885;10459.790804184026;10640.574377024832;11150.219484635998;11244.381559014333;11444.599439019927;11960.58137965167;12285.815712764137;12447.688807779878;12561;12928.095033347576;11367.658970230907;11571.942140289244;11610.24533405326;11647.708807279885;11910.702232444259;9977.301588888708;11150.944245278723;11342;11357.148213883827;11466.77066458683;10190.43952582615;11262.662120136409;11318.4906679198;11349.54601815918;12169.452374643339;9390.859137113086;9927.602895884083;10206.438645874252;10256.38461692301;10540.841887371542;9773.364731292444;10058.396496210251;10221.182305415698;10259.435731034864;10261.84607230907 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,745 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: __startTimestamp1454767730731__endTimestamp 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,744 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:08:50 INFO - 2016-02-06 06:08:50,745 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:08:50 INFO - 2016-02-06 06:08:50,745 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,745 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5600.33 Median:5832.27 stddev:626.86 (10.7%) stddev-sans-first:601.10 06:08:50 INFO - 2016-02-06 06:08:50,745 DEBUG : BROWSER_OUTPUT: Values: 3251.8 3367.2 3401.0 3404.0 3432.1 5608.9 5642.3 5653.3 5674.6 5682.5 5682.7 5689.9 5695.9 5707.4 5710.0 4908.8 5134.4 5173.3 5239.2 5251.5 5008.4 5123.7 5141.6 5143.8 5147.5 5096.2 5156.5 5173.4 5177.4 5185.4 5104.6 5120.1 5147.8 5151.9 5163.6 4952.8 4966.6 5038.4 5054.8 5069.1 5393.9 5425.3 5435.2 5436.1 5437.9 5989.6 6028.5 6052.8 6061.2 6065.3 5859.6 5971.3 6013.4 6114.7 6125.9 5674.0 5692.9 5697.2 5701.6 5707.1 6126.6 6138.9 6141.4 6151.4 6153.8 5795.7 5888.6 5917.2 5955.5 6074.3 6039.2 6047.1 6052.1 6052.7 6060.0 5975.9 5984.3 6010.2 6017.1 6024.5 5673.8 5851.7 5887.5 5989.1 6012.7 4594.1 4596.0 4598.4 4600.4 4619.7 4130.5 4136.5 4142.6 4145.9 4160.4 5469.0 5562.7 5608.2 5648.9 5661.5 6094.5 6122.6 6122.9 6124.6 6125.8 5697.7 5704.1 5712.2 5718.2 5719.4 5052.1 5173.5 5204.1 5269.4 5312.8 6249.7 6251.2 6255.1 6259.2 6264.5 6069.6 6120.4 6129.5 6131.9 6134.1 5897.8 6000.9 6122.7 6256.6 6257.2 5998.1 6041.4 6046.2 6048.3 6078.2 5891.1 6125.8 6151.6 6152.4 6154.7 5797.6 5810.4 5946.1 5954.1 5963.3 5893.7 5934.2 5936.4 5939.9 5942.9 5651.2 5680.5 5832.3 5845.8 5850.2 5853.1 5882.5 5927.8 5929.9 5943.7 5787.5 5866.1 5873.0 5876.6 5880.1 06:08:50 INFO - 2016-02-06 06:08:50,745 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,745 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51585.25 Median:21120.49 stddev:87006.42 (412.0%) stddev-sans-first:87166.23 06:08:50 INFO - 2016-02-06 06:08:50,747 DEBUG : BROWSER_OUTPUT: Values: 584.4 624.3 625.4 629.7 640.5 33255.0 39641.4 39665.0 39748.0 40254.6 43065.6 43544.6 43551.3 43661.3 43718.0 8060.0 8207.6 8939.5 9117.1 9184.8 10278.5 10349.5 10428.4 10458.5 10460.3 10501.9 10637.2 10653.6 10655.2 10660.4 10493.7 10533.6 10551.8 10556.2 10593.2 10395.7 10545.4 10552.4 10567.5 10567.9 41732.6 42007.6 42031.8 42059.8 42151.2 3239.7 3355.3 3624.4 3728.6 3934.0 31193.5 31519.7 31560.7 31606.7 33988.7 4257.5 4337.1 4355.7 4382.5 4404.4 276153.0 278016.0 278656.0 279192.0 279735.0 61393.4 61411.4 61786.4 61944.7 63325.4 57453.1 58133.7 58169.7 72076.0 72957.3 15097.7 15137.5 15248.8 15251.0 15281.5 11598.9 11625.9 11643.4 11653.9 11677.9 21453.5 21824.1 21854.9 21881.2 21893.1 7693.5 8065.5 8081.4 8222.8 8256.0 945.7 1008.0 1009.5 1023.1 1107.3 33851.3 34072.0 34339.5 34496.7 34793.5 1048.2 1049.3 1061.7 1063.8 1114.0 14640.6 15491.6 15840.5 17274.8 17354.5 395641.0 403863.0 404908.0 404978.0 405522.0 55340.0 55431.2 55667.0 55863.4 56200.2 1404.5 1411.6 1426.0 1428.6 1435.7 30895.0 30915.8 31063.5 31485.0 31732.5 47676.5 48113.0 50979.5 51248.7 51497.7 298231.0 299656.0 302847.0 305017.0 305937.0 44303.8 44689.9 44904.3 44925.8 45679.8 48001.0 48216.5 48416.0 49368.5 49581.3 40319.2 41240.2 41551.8 41617.4 41952.0 41064.6 43454.8 44326.0 45303.3 45470.5 39589.6 39723.2 39937.0 43889.8 44550.1 34612.3 35125.8 38512.4 39332.8 40610.6 26186.7 26920.5 27021.6 27029.6 27039.5 06:08:50 INFO - 2016-02-06 06:08:50,747 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,747 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32232.28 Median:20516.14 stddev:104584.58 (509.8%) stddev-sans-first:104850.61 06:08:50 INFO - 2016-02-06 06:08:50,748 DEBUG : BROWSER_OUTPUT: Values: 373.4 375.5 375.7 378.0 378.9 15280.4 16671.2 16832.8 18336.2 19030.3 16399.8 16420.8 16656.2 16690.5 16770.8 3889.6 5060.2 5183.0 5191.1 5191.7 3985.5 5544.0 5731.7 5732.5 5734.8 5648.7 5669.0 5707.8 5709.6 6163.4 6068.6 6101.4 6102.2 6113.9 6114.2 5299.0 5402.5 5407.7 5418.5 5489.1 20221.6 20350.7 20681.6 21577.7 21747.8 2291.5 2397.7 2461.6 2493.4 2509.5 9756.9 9818.2 9907.9 9989.9 10169.0 1927.7 1998.2 2004.2 2016.6 2023.8 63450.4 65400.0 65853.7 66191.3 66811.0 10040.4 10211.2 10278.8 10292.1 10338.3 13419.3 13432.3 13444.9 13458.1 13459.0 7310.7 7332.8 7334.3 7388.2 7396.6 7019.7 7062.1 7076.8 7116.4 7152.8 4106.4 4289.4 4309.8 4413.3 4716.9 1722.6 1736.7 1795.7 1822.5 1844.2 845.8 928.8 932.2 1002.6 1009.3 14230.4 15848.8 16042.7 16755.2 17601.0 938.3 1001.1 1025.7 1027.5 1047.3 9466.9 9835.7 10064.9 10311.3 10366.8 632914.0 633993.0 641401.0 642400.0 647901.0 84373.6 87555.0 88406.0 89825.0 91996.0 1138.7 1154.2 1157.3 1159.4 1170.4 16105.9 16225.2 16231.3 16252.8 16612.3 36973.3 37352.0 37545.6 37780.4 38725.4 48276.8 50455.0 51332.0 52271.2 53876.0 9823.5 10069.4 10093.0 10152.8 10229.2 12120.6 12178.5 12195.1 12299.4 13829.4 14635.4 14734.6 15333.8 15378.2 15605.0 12569.9 12825.3 14604.8 14869.1 15316.1 15382.5 15432.9 15567.8 15758.4 15767.9 10044.6 10232.6 10265.3 10326.9 10483.1 10457.7 11754.6 14786.9 14817.1 15022.0 06:08:50 INFO - 2016-02-06 06:08:50,748 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,748 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5862.09 Median:5060.02 stddev:3091.72 (61.1%) stddev-sans-first:3083.00 06:08:50 INFO - 2016-02-06 06:08:50,748 DEBUG : BROWSER_OUTPUT: Values: 1498.5 1513.7 1683.7 1772.7 1824.8 7847.5 8277.2 8280.4 8307.5 8323.3 7498.9 7615.0 7997.6 8286.0 8487.1 2311.7 2333.4 2345.5 2349.5 2358.8 2111.7 2427.2 2455.3 2464.6 2471.4 2144.5 2340.9 2421.5 2422.5 2422.6 2372.2 2372.9 2374.0 2424.3 2424.8 2397.6 2411.5 2424.9 2425.1 2450.5 8386.5 8408.9 8458.0 8458.7 8468.0 4918.8 5065.4 5065.4 5068.5 5069.5 3271.8 3296.7 3340.4 3363.2 3371.8 1123.0 1146.2 1151.7 1163.3 1201.2 11883.1 11899.3 11903.6 11928.3 11948.8 4489.6 4494.7 4503.4 4528.8 4549.7 10029.3 10048.1 10051.8 10061.6 10066.5 5054.6 5087.3 5094.0 5104.0 5109.8 4629.5 4641.4 4643.4 4645.6 4646.3 3909.7 3939.1 3977.3 3980.4 4007.7 1165.7 1177.7 1219.6 1264.2 1279.8 1052.8 1079.0 1086.7 1247.7 1373.0 7868.5 7895.7 7947.0 7952.4 7984.0 1124.8 1138.3 1140.0 1144.3 1160.5 5647.1 5689.4 5703.7 5704.7 5708.4 9897.3 10077.0 10282.7 10304.1 10402.5 10213.2 10222.1 10229.7 10232.6 10238.9 7712.4 7897.2 7976.6 7985.0 8013.0 7519.9 7649.3 7685.3 7686.2 7692.5 8991.6 8993.9 9068.0 9178.7 9212.1 9334.8 9347.2 9355.6 9494.8 9598.8 7481.6 7555.9 7556.4 7565.5 7571.5 8165.8 8183.9 8187.0 8190.3 8247.1 6796.5 7727.4 7781.1 7794.7 7870.3 7042.3 7602.0 7663.1 7743.0 7821.4 6963.9 7003.8 7008.4 7009.6 7010.3 6725.3 6725.8 6749.6 6757.7 6793.3 6834.7 6864.5 6865.7 6870.9 6871.2 06:08:50 INFO - 2016-02-06 06:08:50,749 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,749 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5480.06 Median:6206.55 stddev:1639.54 (26.4%) stddev-sans-first:1598.44 06:08:50 INFO - 2016-02-06 06:08:50,749 DEBUG : BROWSER_OUTPUT: Values: 358.8 363.3 366.4 366.8 368.2 6117.7 6145.6 6166.9 6180.0 6188.7 5816.1 5944.8 5977.0 6092.2 6102.7 4723.2 4729.1 4729.2 4735.9 4745.0 4717.1 4730.4 4733.9 4743.1 4744.1 4514.6 4560.3 4601.3 4654.2 4700.9 4643.0 4651.4 4678.8 4689.2 4693.1 4131.5 4134.5 4139.5 4141.2 4154.2 5783.2 5787.9 5792.9 5796.1 5796.7 5377.2 5492.9 5497.3 5497.5 5497.5 6451.2 6456.8 6457.2 6458.1 6464.0 4585.7 4586.6 4587.8 4588.1 4596.9 6554.6 6668.7 6681.8 6683.6 6684.7 4705.1 4705.6 4715.6 4717.7 4722.4 4765.1 4768.2 4768.7 4779.1 4788.0 5454.1 5458.8 5463.2 5471.2 5479.8 6326.8 6471.8 6530.6 6539.6 6564.0 1659.9 1680.2 1682.8 1683.6 1685.1 1124.0 1124.9 1128.7 1137.6 1149.0 6321.0 6324.6 6333.4 6334.4 6337.3 6750.3 6752.0 6756.9 6758.4 6762.6 6112.4 6224.4 6265.2 6320.8 6377.1 3646.7 3662.7 3686.7 3690.1 3690.3 6954.3 6959.5 6975.5 6975.6 6976.8 6736.0 6905.5 6922.8 6938.5 6960.2 6919.8 6975.2 6983.1 6991.9 6994.5 6804.4 6809.7 6810.3 6813.6 6832.2 6512.9 6697.4 6728.4 6744.3 6745.3 6940.6 6971.4 6975.0 6978.7 6984.2 4701.2 4739.8 4740.4 4741.6 4747.8 6681.2 6795.2 6801.6 6806.5 6808.7 6630.5 6637.8 6638.5 6639.0 6648.4 6504.1 6613.9 6625.6 6629.1 6635.2 6486.7 6507.3 6512.1 6520.6 6523.1 6572.4 6613.8 6633.8 6635.5 6640.0 6365.6 6471.1 6489.4 6497.5 6501.4 06:08:50 INFO - 2016-02-06 06:08:50,749 DEBUG : BROWSER_OUTPUT: 06:08:50 INFO - 2016-02-06 06:08:50,749 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14164.71 Median:49459.51 stddev:16839.49 (34.0%) stddev-sans-first:16856.93 06:08:50 INFO - 2016-02-06 06:08:50,750 DEBUG : BROWSER_OUTPUT: Values: 825.4 884.1 893.0 901.6 906.9 12995.2 13262.1 13278.1 13285.7 13305.7 12769.3 12848.9 12919.5 12945.9 12975.2 739.9 750.3 857.1 860.2 875.4 870.7 877.0 877.4 877.4 878.1 782.6 922.8 927.3 928.7 929.2 779.2 886.9 898.5 899.6 901.2 669.6 669.9 670.0 670.4 670.8 12038.5 12110.2 12114.3 12129.5 12323.7 12014.5 12281.9 12506.4 12517.2 13002.2 10356.6 10521.9 10710.7 10731.4 10780.2 3729.9 3828.4 3833.1 3833.8 3843.9 49394.8 49589.3 50557.0 51222.5 51307.7 8566.7 8613.8 8637.3 8638.2 8716.4 16225.6 16235.1 16265.4 16286.4 16290.8 7274.3 7742.5 7774.7 7813.6 7977.4 4170.3 4205.3 4328.4 4378.4 4387.8 3209.6 3221.9 3242.0 3255.2 3266.7 557.4 572.3 581.0 583.8 587.5 526.5 626.9 648.1 648.8 666.7 8542.0 8961.9 9063.5 9368.7 9710.3 531.6 582.8 668.3 685.3 715.8 4049.8 4104.9 4268.3 4344.5 4361.2 60476.0 61348.7 61508.0 62728.7 62829.7 49895.8 50074.5 50254.5 50412.5 53675.7 49228.3 49539.3 49624.8 49649.3 49961.5 8475.6 8623.3 8798.1 8807.5 8828.3 36312.5 36794.3 37367.4 37915.8 38273.6 44014.0 48533.3 49249.5 49524.3 49583.5 10459.8 10640.6 11150.2 11244.4 11444.6 11960.6 12285.8 12447.7 12561.0 12928.1 11367.7 11571.9 11610.2 11647.7 11910.7 9977.3 11150.9 11342.0 11357.1 11466.8 10190.4 11262.7 11318.5 11349.5 12169.5 9390.9 9927.6 10206.4 10256.4 10540.8 9773.4 10058.4 10221.2 10259.4 10261.8 06:08:50 INFO - 2016-02-06 06:08:50,750 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:08:50 INFO - 2016-02-06 06:08:50,751 DEBUG : BROWSER_OUTPUT: 06:08:51 INFO - 2016-02-06 06:08:51,307 INFO : Browser exited with error code: 0 06:08:51 INFO - 2016-02-06 06:08:51,325 INFO : Completed test dromaeo_css (00:18:30) 06:08:51 INFO - 2016-02-06 06:08:51,325 INFO : Starting test kraken 06:08:51 INFO - 2016-02-06 06:08:51,325 DEBUG : operating with platform_type : linux_ 06:08:51 INFO - 2016-02-06 06:08:51,325 INFO : Initialising browser for kraken test... 06:08:51 INFO - 2016-02-06 06:08:51,331 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeDdTKz/profile http://localhost:43258/getInfo.html 06:08:55 INFO - 2016-02-06 06:08:55,228 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:08:55 INFO - 2016-02-06 06:08:55,228 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:08:55 INFO - 2016-02-06 06:08:55,228 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:08:55 INFO - 2016-02-06 06:08:55,229 DEBUG : BROWSER_OUTPUT: __metrics 06:08:55 INFO - 2016-02-06 06:08:55,446 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:56 INFO - 2016-02-06 06:08:56,523 INFO : Browser initialized. 06:08:56 INFO - 2016-02-06 06:08:56,523 INFO : Running cycle 1/1 for kraken test... 06:08:56 INFO - 2016-02-06 06:08:56,523 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeDdTKz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:09:08 INFO - 2016-02-06 06:09:08,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 134316032 06:09:08 INFO - 2016-02-06 06:09:08,304 DEBUG : BROWSER_OUTPUT: 06:09:10 INFO - 2016-02-06 06:09:10,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43258/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:11 INFO - 2016-02-06 06:09:11,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 167825408 06:09:11 INFO - 2016-02-06 06:09:11,300 DEBUG : BROWSER_OUTPUT: 06:09:13 INFO - 2016-02-06 06:09:13,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43258/tests/kraken/driver.html?testName=audio-dft) 06:09:14 INFO - 2016-02-06 06:09:14,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 165965824 06:09:14 INFO - 2016-02-06 06:09:14,479 DEBUG : BROWSER_OUTPUT: 06:09:17 INFO - 2016-02-06 06:09:17,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43258/tests/kraken/driver.html?testName=audio-fft) 06:09:17 INFO - 2016-02-06 06:09:17,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 162668544 06:09:17 INFO - 2016-02-06 06:09:17,819 DEBUG : BROWSER_OUTPUT: 06:09:19 INFO - 2016-02-06 06:09:19,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43258/tests/kraken/driver.html?testName=audio-oscillator) 06:09:20 INFO - 2016-02-06 06:09:20,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 161357824 06:09:20 INFO - 2016-02-06 06:09:20,377 DEBUG : BROWSER_OUTPUT: 06:09:22 INFO - 2016-02-06 06:09:22,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:23 INFO - 2016-02-06 06:09:23,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 158900224 06:09:23 INFO - 2016-02-06 06:09:23,111 DEBUG : BROWSER_OUTPUT: 06:09:25 INFO - 2016-02-06 06:09:25,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43258/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:26 INFO - 2016-02-06 06:09:26,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 160034816 06:09:26 INFO - 2016-02-06 06:09:26,501 DEBUG : BROWSER_OUTPUT: 06:09:29 INFO - 2016-02-06 06:09:29,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43258/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:30 INFO - 2016-02-06 06:09:30,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 160702464 06:09:30 INFO - 2016-02-06 06:09:30,376 DEBUG : BROWSER_OUTPUT: 06:09:33 INFO - 2016-02-06 06:09:33,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43258/tests/kraken/driver.html?testName=json-parse-financial) 06:09:33 INFO - 2016-02-06 06:09:33,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 159686656 06:09:33 INFO - 2016-02-06 06:09:33,701 DEBUG : BROWSER_OUTPUT: 06:09:35 INFO - 2016-02-06 06:09:35,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:35 INFO - 2016-02-06 06:09:35,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 169209856 06:09:35 INFO - 2016-02-06 06:09:35,804 DEBUG : BROWSER_OUTPUT: 06:09:37 INFO - 2016-02-06 06:09:37,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:38 INFO - 2016-02-06 06:09:38,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 167440384 06:09:38 INFO - 2016-02-06 06:09:38,176 DEBUG : BROWSER_OUTPUT: 06:09:40 INFO - 2016-02-06 06:09:40,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:40 INFO - 2016-02-06 06:09:40,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 172068864 06:09:40 INFO - 2016-02-06 06:09:40,728 DEBUG : BROWSER_OUTPUT: 06:09:43 INFO - 2016-02-06 06:09:43,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:43 INFO - 2016-02-06 06:09:43,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 176087040 06:09:43 INFO - 2016-02-06 06:09:43,644 DEBUG : BROWSER_OUTPUT: 06:09:46 INFO - 2016-02-06 06:09:46,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:46 INFO - 2016-02-06 06:09:46,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 175226880 06:09:46 INFO - 2016-02-06 06:09:46,715 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43258/tests/kraken/driver.html?testName=ai-astar) 06:09:48 INFO - 2016-02-06 06:09:48,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 233488384 06:09:48 INFO - 2016-02-06 06:09:48,579 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;102;107;108;110;99;109;107;107 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;121;156;164;124;149;145;121;158;130 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;160;160;161;161;161;160;162;160;159 06:09:48 INFO - 2016-02-06 06:09:48,583 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;77;71;150;71;71;70;71;156;71 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;134;92;92;93;134;91;92;130 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;108;109;109;109;109 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;145;145;145;145;145;146 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;95;95;96;96 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;56;56;56;56;58;57;59;56 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;64;65;64;65;64;64;65 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;77;84;78;79;78;86;77;78;82 06:09:48 INFO - 2016-02-06 06:09:48,584 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;114;110;115;113;111;128;112;113;120 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;137;144;144;155;138;143;146;142;145 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;65;64;65;63;65;64;64;64 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:09:48 INFO - 2016-02-06 06:09:48,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1454767788581__endTimestamp 06:09:48 INFO - 2016-02-06 06:09:48,586 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.50 Median:108.50 stddev:3.41 (3.1%) stddev-sans-first:3.61 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 102.0 107.0 108.0 110.0 99.0 109.0 107.0 107.0 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.50 Median:148.00 stddev:16.22 (11.0%) stddev-sans-first:17.08 06:09:48 INFO - 2016-02-06 06:09:48,589 DEBUG : BROWSER_OUTPUT: Values: 147.0 121.0 156.0 164.0 124.0 149.0 145.0 121.0 158.0 130.0 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: Values: 159.0 160.0 160.0 161.0 161.0 161.0 160.0 162.0 160.0 159.0 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.80 Median:71.00 stddev:34.45 (48.5%) stddev-sans-first:35.93 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: Values: 70.0 77.0 71.0 150.0 71.0 71.0 70.0 71.0 156.0 71.0 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:92.00 stddev:19.55 (21.2%) stddev-sans-first:20.29 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 134.0 92.0 92.0 93.0 134.0 91.0 92.0 130.0 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:09:48 INFO - 2016-02-06 06:09:48,590 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:1.18 (2.1%) stddev-sans-first:1.12 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 56.0 56.0 56.0 56.0 58.0 57.0 59.0 56.0 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:78.50 stddev:3.16 (4.0%) stddev-sans-first:3.30 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: Values: 78.0 77.0 84.0 78.0 79.0 78.0 86.0 77.0 78.0 82.0 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:114.50 stddev:5.44 (4.8%) stddev-sans-first:5.62 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: Values: 119.0 114.0 110.0 115.0 113.0 111.0 128.0 112.0 113.0 120.0 06:09:48 INFO - 2016-02-06 06:09:48,591 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:144.00 stddev:5.34 (3.7%) stddev-sans-first:5.19 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: Values: 137.0 137.0 144.0 144.0 155.0 138.0 143.0 146.0 142.0 145.0 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 64.0 65.0 63.0 65.0 64.0 64.0 64.0 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:09:48 INFO - 2016-02-06 06:09:48,592 DEBUG : BROWSER_OUTPUT: 06:09:49 INFO - 2016-02-06 06:09:49,295 INFO : Browser exited with error code: 0 06:09:49 INFO - 2016-02-06 06:09:49,350 INFO : Completed test kraken (00:00:58) 06:09:49 INFO - 2016-02-06 06:09:49,350 INFO : Starting test v8_7 06:09:49 INFO - 2016-02-06 06:09:49,350 DEBUG : operating with platform_type : linux_ 06:09:49 INFO - 2016-02-06 06:09:49,351 INFO : Initialising browser for v8_7 test... 06:09:49 INFO - 2016-02-06 06:09:49,357 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpybWKwT/profile http://localhost:43258/getInfo.html 06:09:53 INFO - 2016-02-06 06:09:53,528 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:09:53 INFO - 2016-02-06 06:09:53,529 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:09:53 INFO - 2016-02-06 06:09:53,529 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:09:53 INFO - 2016-02-06 06:09:53,529 DEBUG : BROWSER_OUTPUT: __metrics 06:09:53 INFO - 2016-02-06 06:09:53,714 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:09:54 INFO - 2016-02-06 06:09:54,362 INFO : Browser initialized. 06:09:54 INFO - 2016-02-06 06:09:54,362 INFO : Running cycle 1/1 for v8_7 test... 06:09:54 INFO - 2016-02-06 06:09:54,362 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpybWKwT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:10:06 INFO - 2016-02-06 06:10:06,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 134799360 06:10:06 INFO - 2016-02-06 06:10:06,171 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43258/tests/v8_7/run.html (next: http://localhost:43258/tests/v8_7/run.html) 06:10:27 INFO - 2016-02-06 06:10:27,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 422031360 06:10:27 INFO - 2016-02-06 06:10:27,773 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,773 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:10:27 INFO - 2016-02-06 06:10:27,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:10:27 INFO - 2016-02-06 06:10:27,773 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:10:27 INFO - 2016-02-06 06:10:27,773 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:10:27 INFO - 2016-02-06 06:10:27,773 DEBUG : BROWSER_OUTPUT: |0;Richards;172.0578114246387 06:10:27 INFO - 2016-02-06 06:10:27,774 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.44486108743823 06:10:27 INFO - 2016-02-06 06:10:27,774 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 06:10:27 INFO - 2016-02-06 06:10:27,774 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 06:10:27 INFO - 2016-02-06 06:10:27,774 DEBUG : BROWSER_OUTPUT: |4;RayTrace;950.5703422053232 06:10:27 INFO - 2016-02-06 06:10:27,774 DEBUG : BROWSER_OUTPUT: |5;Earley;542.0054200542005 06:10:27 INFO - 2016-02-06 06:10:27,775 DEBUG : BROWSER_OUTPUT: |6;Boyer;10547.368421052632 06:10:27 INFO - 2016-02-06 06:10:27,775 DEBUG : BROWSER_OUTPUT: |7;RegExp;24119.04761904762 06:10:27 INFO - 2016-02-06 06:10:27,775 DEBUG : BROWSER_OUTPUT: |8;Splay;526.592943654555 06:10:27 INFO - 2016-02-06 06:10:27,775 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 06:10:27 INFO - 2016-02-06 06:10:27,775 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:10:27 INFO - 2016-02-06 06:10:27,776 DEBUG : BROWSER_OUTPUT: __startTimestamp1454767827766__endTimestamp 06:10:27 INFO - 2016-02-06 06:10:27,776 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,776 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:10:27 INFO - 2016-02-06 06:10:27,776 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:10:27 INFO - 2016-02-06 06:10:27,776 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,777 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.06 Median:172.06 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,777 DEBUG : BROWSER_OUTPUT: Values: 172.1 06:10:27 INFO - 2016-02-06 06:10:27,777 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,777 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.44 Median:170.44 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,777 DEBUG : BROWSER_OUTPUT: Values: 170.4 06:10:27 INFO - 2016-02-06 06:10:27,778 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,778 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,778 DEBUG : BROWSER_OUTPUT: Values: 277.7 06:10:27 INFO - 2016-02-06 06:10:27,778 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,778 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,779 DEBUG : BROWSER_OUTPUT: Values: 5112.2 06:10:27 INFO - 2016-02-06 06:10:27,779 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,779 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:950.57 Median:950.57 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,779 DEBUG : BROWSER_OUTPUT: Values: 950.6 06:10:27 INFO - 2016-02-06 06:10:27,779 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,780 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.01 Median:542.01 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,780 DEBUG : BROWSER_OUTPUT: Values: 542.0 06:10:27 INFO - 2016-02-06 06:10:27,780 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,780 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10547.37 Median:10547.37 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,780 DEBUG : BROWSER_OUTPUT: Values: 10547.4 06:10:27 INFO - 2016-02-06 06:10:27,781 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,781 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24119.05 Median:24119.05 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,781 DEBUG : BROWSER_OUTPUT: Values: 24119.0 06:10:27 INFO - 2016-02-06 06:10:27,781 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,781 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:526.59 Median:526.59 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,781 DEBUG : BROWSER_OUTPUT: Values: 526.6 06:10:27 INFO - 2016-02-06 06:10:27,782 DEBUG : BROWSER_OUTPUT: 06:10:27 INFO - 2016-02-06 06:10:27,782 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 06:10:27 INFO - 2016-02-06 06:10:27,782 DEBUG : BROWSER_OUTPUT: Values: 4826.9 06:10:27 INFO - 2016-02-06 06:10:27,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:10:27 INFO - 2016-02-06 06:10:27,782 DEBUG : BROWSER_OUTPUT: 06:10:28 INFO - 2016-02-06 06:10:28,415 INFO : Browser exited with error code: 0 06:10:28 INFO - 2016-02-06 06:10:28,426 INFO : Completed test v8_7 (00:00:39) 06:10:28 INFO - 2016-02-06 06:10:28,802 INFO : Completed test suite (00:20:07) 06:10:28 INFO - 2016-02-06 06:10:28,802 DEBUG : Working with test: dromaeo_css 06:10:28 INFO - 2016-02-06 06:10:28,802 DEBUG : Generating results file: dromaeo_css 06:10:28 INFO - 2016-02-06 06:10:28,803 DEBUG : Working with test: kraken 06:10:28 INFO - 2016-02-06 06:10:28,803 DEBUG : Generating results file: kraken 06:10:28 INFO - 2016-02-06 06:10:28,803 INFO : javascript benchmark 06:10:28 INFO - 2016-02-06 06:10:28,804 DEBUG : Working with test: v8_7 06:10:28 INFO - 2016-02-06 06:10:28,804 DEBUG : Generating results file: v8_7 06:10:28 INFO - 2016-02-06 06:10:28,804 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:28 INFO - 2016-02-06 06:10:28,871 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 06:10:28 INFO - 2016-02-06 06:10:28,871 DEBUG : process_Request line: dromaeo_css 7343.48 graph.html#tests=[[72,53,35]] 06:10:28 INFO - 2016-02-06 06:10:28,871 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:29 INFO - 2016-02-06 06:10:29,013 DEBUG : process_Request line: kraken 1473.60 graph.html#tests=[[232,53,35]] 06:10:29 INFO - 2016-02-06 06:10:29,013 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:10:29 INFO - 2016-02-06 06:10:29,061 DEBUG : process_Request line: v8_7 23183.33 graph.html#tests=[[230,53,35]] 06:10:29 INFO - 2016-02-06 06:10:29,062 INFO : javascript benchmark 06:10:29 INFO - 2016-02-06 06:10:29,066 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3251.7561182911286, 3367.2255381262294, 3400.9659903400957, 3403.9829800850994, 3432.124808173916, 5608.887822243552, 5642.294713160855, 5653.293338332708, 5674.60277780555, 5682.516986056185, 5682.744276507557, 5689.9146512802345, 5695.914561281584, 5707.429257074301, 5710.0, 4908.8281910133155, 5134.409542902558, 5173.275741396207, 5239.21411788231, 5251.474852514737, 5008.4240312364, 5123.666961647481, 5141.5886729061585, 5143.794248230066, 5147.48525147486, 5096.210087436453, 5156.53591176794, 5173.430922598511, 5177.352830896138, 5185.403678576974, 5104.566111880495, 5120.1039818031695, 5147.819826306099, 5151.922721159186, 5163.586913046966, 4952.826651067231, 4966.602671786249, 5038.39539255288, 5054.772535235887, 5069.087564238435, 5393.946060539383, 5425.294711687456, 5435.211894275348, 5436.103042997901, 5437.918431223496, 5989.5507836911975, 6028.457438830483, 6052.818415447544, 6061.181740465025, 6065.302490213594, 5859.6191247569195, 5971.253593300838, 6013.36859629737, 6114.663693496856, 6125.908111378333, 5674.0, 5692.8861422771315, 5697.202391665171, 5701.572382071278, 5707.1153971134545, 6126.632402055891, 6138.877222455615, 6141.355157708376, 6151.415615516519, 6153.8307721532765, 5795.652260864277, 5888.646681199056, 5917.171595976567, 5955.52355811534, 6074.271087469444, 6039.1545183674325, 6047.123167140828, 6052.12244224585, 6052.6671033092725, 6060.0, 5975.910361344583, 5984.3417224105315, 6010.2186715726675, 6017.1275165100815, 6024.487918526975, 5673.8297851064535, 5851.707414629252, 5887.4701276884425, 5989.131575921554, 6012.699365031731, 4594.1271158479785, 4595.954040459619, 4598.425196850327, 4600.35595016698, 4619.722816631013, 4130.463039804867, 4136.544980052192, 4142.5857414258935, 4145.854895078658, 4160.396742472324, 5469.0, 5562.694051827189, 5608.158776183605, 5648.85877853057, 5661.46216109469, 6094.512439004869, 6122.571420000646, 6122.908156377658, 6124.6325220486915, 6125.785597504155, 5697.658140511582, 5704.1443783432815, 5712.2288491054005, 5718.228039214736, 5719.370869204384, 5052.141136006888, 5173.482651734872, 5204.063268611686, 5269.420363759983, 5312.787488500494, 6249.6875156242, 6251.156093927352, 6255.124282600348, 6259.248890133122, 6264.467520260829, 6069.635821850703, 6120.418560236771, 6129.509639228761, 6131.938680613315, 6134.141220229082, 5897.764089436546, 6000.8799824004145, 6122.672617327995, 6256.562040657111, 6257.155284036597, 5998.100284957117, 6041.426064523863, 6046.222354902177, 6048.334683184934, 6078.209832721895, 5891.1457838612305, 6125.816225513242, 6151.630902145886, 6152.415520525543, 6154.661493617894, 5797.594168408171, 5810.448007439287, 5946.108083787466, 5954.07711804671, 5963.254593175853, 5893.675847828411, 5934.169216309634, 5936.436038576328, 5939.910901336397, 5942.910856337245, 5651.15232715096, 5680.460356266148, 5832.270966129234, 5845.766169353178, 5850.151727999331, 5853.0635098384055, 5882.499266180025, 5927.8221653350465, 5929.881402372014, 5943.673097979653, 5787.479126878601, 5866.120081987736, 5873.03094989322, 5876.588638795243, 5880.059190529495], "unit": "ms", "name": "dojo.html", "value": 5559.428378647227}, {"lowerIsBetter": false, "replicates": [584.3688816078635, 624.3350831364594, 625.3871206217909, 629.6977450823605, 640.4876099120702, 33255.0, 39641.40537891934, 39665.0, 39748.0, 40254.597454025454, 43065.56934430655, 43544.564554354445, 43551.346729799, 43661.345079823746, 43718.0, 8059.95970020152, 8207.58962051898, 8939.508327042011, 9117.133872282122, 9184.770380740501, 10278.486075696223, 10349.534270957787, 10428.426436545988, 10458.4770761462, 10460.267781255316, 10501.894981050207, 10637.202209834293, 10653.573857045747, 10655.200859935498, 10660.360378377283, 10493.737656558571, 10533.631322903662, 10551.78896422071, 10556.208284378703, 10593.205509586773, 10395.740106497322, 10545.420001899893, 10552.366857988469, 10567.524461399256, 10567.94716026415, 41732.58267417317, 42007.57992420098, 42031.78984105091, 42059.7897010516, 42151.1569768606, 3239.740820734359, 3355.328934213167, 3624.3657359961903, 3728.5525736911472, 3934.0, 31193.532097018335, 31519.684803151904, 31560.684393156003, 31606.683933160835, 33988.66011339904, 4257.489101307832, 4337.132573485315, 4355.673324500675, 4382.496012958519, 4404.4054052702795, 276153.0, 278016.0, 278656.0, 279192.0, 279735.0, 61393.386066138766, 61411.38588614146, 61786.382136178065, 61944.69027654833, 63325.36674633287, 57453.13820292699, 58133.709331453916, 58169.709151454816, 72076.0, 72957.27042729611, 15097.698046039017, 15137.545873623809, 15248.847511524742, 15251.0, 15281.46514871974, 11598.88401115995, 11625.88374116265, 11643.41782910851, 11653.941730291293, 11677.88322116785, 21453.463663408227, 21824.127034918427, 21854.89072554627, 21881.234156804436, 21893.124275028822, 7693.461457698019, 8065.459380295189, 8081.393895457864, 8222.794430139294, 8256.0, 945.7021038372891, 1008.0423597582326, 1009.4801177393648, 1023.1150055202345, 1107.2692023264606, 33851.322973540395, 34072.0, 34339.4849077264, 34496.655033449846, 34793.478097828556, 1048.2400259811727, 1049.270756824, 1061.7398737309254, 1063.829787234042, 1113.9665810025713, 14640.633984150481, 15491.612709682122, 15840.52478425626, 17274.827251727573, 17354.479365619052, 395641.0, 403863.0, 404908.0, 404978.0, 405522.0, 55340.0, 55431.168532472046, 55667.0, 55863.44136558582, 56200.15699764507, 1404.501402002295, 1411.647088227943, 1425.9928700356431, 1428.5857101440465, 1435.7056803355288, 30895.0, 30915.845420772752, 31063.534046989764, 31485.0, 31732.524012139376, 47676.523234767206, 48113.0, 50979.490205098955, 51248.74375628098, 51497.7425112872, 298231.0, 299656.0, 302847.0, 305017.0, 305937.0, 44303.77848110739, 44689.882752930134, 44904.32643510415, 44925.77537112294, 45679.77160114178, 48001.0, 48216.5178348226, 48416.0, 49368.50631493639, 49581.25628115509, 40319.18563664701, 41240.1751964953, 41551.7922410386, 41617.37573936454, 41952.0, 41064.58935410727, 43454.78272608617, 44326.0, 45303.320450192616, 45470.54529454663, 39589.60410395859, 39723.2055358897, 39937.003149842974, 43889.78055109704, 44550.10899781921, 34612.307753845285, 35125.824370879, 38512.42231366588, 39332.80333598314, 40610.59389406068, 26186.73813261843, 26920.461590768467, 27021.59467607948, 27029.59455608128, 27039.45921081607], "unit": "ms", "name": "ext.html", "value": 20311.056038813225}, {"lowerIsBetter": false, "replicates": [373.43797584635126, 375.4612131591167, 375.6975634614136, 377.9716521260904, 378.86739641125627, 15280.388784448636, 16671.249793759278, 16832.831671683278, 18336.174872130752, 19030.33393831216, 16399.754003689955, 16420.83579164208, 16656.16719164043, 16690.499285021437, 16770.83229167708, 3889.572147063821, 5060.240963855433, 5183.041137389576, 5191.091558977183, 5191.740412979355, 3985.4619626350363, 5543.972280138593, 5731.656100633954, 5732.48407643312, 5734.827955161351, 5648.6893220872835, 5669.036263835158, 5707.771689132451, 5709.628874123168, 6163.383661633823, 6068.605540639866, 6101.389861013885, 6102.20671312731, 6113.908291375633, 6114.1745864308195, 5298.97350513245, 5402.513773760341, 5407.702576358338, 5418.458154184589, 5489.066858634002, 20221.595568088556, 20350.694739578918, 20681.58636827255, 21577.67633485499, 21747.782522174733, 2291.4958709083976, 2397.688300520921, 2461.59383701689, 2493.351728550572, 2509.5482813093636, 9756.90243097567, 9818.165455936254, 9907.851382229272, 9989.850152247722, 10169.0, 1927.7012063130237, 1998.15078591598, 2004.2484068474323, 2016.647086759826, 2023.7875023122508, 63450.36549634491, 65400.0, 65853.67073164604, 66191.338086619, 66811.0, 10040.397576145455, 10211.183105351554, 10278.845817312746, 10292.125169360688, 10338.328008679411, 13419.329033548283, 13432.261225632488, 13444.932775336061, 13458.125221860548, 13459.0, 7310.744123955636, 7332.816679583053, 7334.303241192185, 7388.187299397062, 7396.593187374746, 7019.684114214872, 7062.117235345582, 7076.823079423056, 7116.359527642537, 7152.821179470451, 4106.425100485934, 4289.356596510486, 4309.827606895689, 4413.293872980308, 4716.858494245178, 1722.6210233748554, 1736.7047601907707, 1795.6678014567347, 1822.4988128264567, 1844.2162081115473, 845.7589586967684, 928.7817362919709, 932.2262522106636, 1002.5739060899089, 1009.3237530854345, 14230.359633816503, 15848.841511584737, 16042.679146417006, 16755.2460139294, 17601.0, 938.3478482454628, 1001.0640051551823, 1025.702546261576, 1027.5376080763685, 1047.3087762076993, 9466.90533094674, 9835.655752048644, 10064.949675251723, 10311.278210525192, 10366.844497332546, 632914.0, 633993.0, 641401.0, 642400.0, 647901.0, 84373.57813210895, 87555.0, 88406.0, 89825.0, 91996.0, 1138.6868611132004, 1154.2209008918946, 1157.3403160198775, 1159.4087015622094, 1170.3504554972071, 16105.919470403041, 16225.18874056316, 16231.269592868113, 16252.837471625133, 16612.335506579602, 36973.26053478861, 37352.0, 37545.62454375421, 37780.43329350007, 38725.41911871268, 48276.758616206695, 50455.0, 51332.0, 52271.21593176181, 53876.0, 9823.459709715748, 10069.446180460145, 10093.0, 10152.79694406093, 10229.232807539613, 12120.575779847662, 12178.512859485521, 12195.146339756131, 12299.385030748606, 13829.446822127002, 14635.41458341697, 14734.557963261119, 15333.846661533242, 15378.154201519024, 15605.0, 12569.93715031419, 12825.294608796607, 14604.780928285873, 14869.107853528823, 15316.081035137928, 15382.461613843461, 15432.9228353862, 15567.844321557093, 15758.369665213722, 15767.921160394124, 10044.648437304659, 10232.64185753495, 10265.332753371007, 10326.896731032593, 10483.108935740547, 10457.68626941193, 11754.588589399329, 14786.926065370035, 14817.110973341634, 15022.0], "unit": "ms", "name": "jquery.html", "value": 9117.649785800322}, {"lowerIsBetter": false, "replicates": [1498.5204734484962, 1513.6972605478904, 1683.730603103503, 1772.663193993142, 1824.7901491328494, 7847.489913155641, 8277.213664701843, 8280.420370574062, 8307.543085130315, 8323.33413326934, 7498.887516687254, 7615.0, 7997.560134192631, 8285.95857020714, 8487.066422693515, 2311.653252012195, 2333.4166458385403, 2345.495718420539, 2349.5418393413293, 2358.8466749661216, 2111.7360329958756, 2427.186892391051, 2455.3002394317623, 2464.581021226396, 2471.369800700819, 2144.4531644430726, 2340.9063637454483, 2421.539907417585, 2422.515496900618, 2422.5518279118332, 2372.2408829174583, 2372.9169479068237, 2373.988130059356, 2424.260600516842, 2424.806015518754, 2397.5924092904247, 2411.46947671512, 2424.9272521824373, 2425.126954296452, 2450.509898020385, 8386.454880432751, 8408.873866892001, 8458.0, 8458.661653533913, 8468.0, 4918.7786549605, 5065.4174769901565, 5065.442801291855, 5068.543831055223, 5069.493050694938, 3271.7873338233176, 3296.670332966708, 3340.4154273002127, 3363.1760218746563, 3371.780834245766, 1123.0459001337695, 1146.1633007904277, 1151.7293436042523, 1163.2671417007316, 1201.1651901928165, 11883.108766842435, 11899.345535995517, 11903.64289071338, 11928.284302941764, 11948.820767688492, 4489.618382437529, 4494.662900282492, 4503.437070366204, 4528.796204170821, 4549.727016378962, 10029.348092373972, 10048.145907597936, 10051.798964020825, 10061.647842325483, 10066.496675166212, 5054.620903432184, 5087.3386459759995, 5094.0, 5104.03023425548, 5109.770060347293, 4629.537046295343, 4641.3734145889875, 4643.396358473445, 4645.558671926162, 4646.303054541846, 3909.706771992112, 3939.054626889526, 3977.3320928010708, 3980.4228386883738, 4007.699422543321, 1165.6736113888126, 1177.7291223018753, 1219.6341097670663, 1264.165650670553, 1279.833621629201, 1052.768390953989, 1079.0180935348794, 1086.7391825961713, 1247.7067889046066, 1372.9862701373058, 7868.527888326718, 7895.684172633145, 7947.0, 7952.403569732293, 7983.960080199562, 1124.798081401679, 1138.2885696439726, 1140.0, 1144.2733863996257, 1160.5183848702864, 5647.068233741469, 5689.402612725604, 5703.686297253608, 5704.71476426177, 5708.372079071299, 9897.257705672104, 10077.0, 10282.742931426774, 10304.072633462874, 10402.531886065146, 10213.182945364353, 10222.080012798884, 10229.74425639365, 10232.59069637206, 10238.897611023795, 7712.383009359238, 7897.210278972172, 7976.641051152712, 7984.960075199587, 8013.038435387674, 7519.887201691869, 7649.349805266615, 7685.308322251024, 7686.231376862269, 7692.538447693157, 8991.550422478718, 8993.910060899307, 9067.954660226656, 9178.67874624385, 9212.078792120734, 9334.766630834283, 9347.205487533636, 9355.578998944928, 9494.810103798023, 9598.760030999281, 7481.625918704151, 7555.886661700189, 7556.433267505069, 7565.546067235983, 7571.545707257582, 8165.755027349189, 8183.918160818554, 8186.959065204635, 8190.262876341158, 8247.051589067334, 6796.456283497408, 7727.42044346665, 7781.144074151725, 7794.688212471665, 7870.331021863206, 7042.260562640849, 7602.049743782028, 7663.080430348394, 7742.961285193538, 7821.374290056896, 6963.93036069653, 7003.789886303419, 7008.404285635778, 7009.649517524205, 7010.334018268256, 6725.327467253235, 6725.798226053226, 6749.595024298558, 6757.662116894234, 6793.252742198453, 6834.658267086526, 6864.519483636297, 6865.725370985305, 6870.931290687029, 6871.175458944958], "unit": "ms", "name": "mootools.html", "value": 4791.540890146866}, {"lowerIsBetter": false, "replicates": [358.79190069759534, 363.26257696875354, 366.38630294257115, 366.8165917041479, 368.1679404545728, 6117.6941152942345, 6145.600535965159, 6166.876662466748, 6180.042093475518, 6188.721507532161, 5816.069428891378, 5944.821655350335, 5976.970115149429, 6092.177556029935, 6102.664353460558, 4723.220668589687, 4729.1251118543005, 4729.2433210686295, 4735.881602959937, 4744.97627511862, 4717.080169366975, 4730.408698912636, 4733.928991065137, 4743.051389722053, 4744.122337367598, 4514.571115743999, 4560.33875088112, 4601.33280674302, 4654.208784506642, 4700.858974230779, 4642.97678511607, 4651.418572678415, 4678.836240731558, 4689.155951928651, 4693.06138772247, 4131.5455299916985, 4134.462519872397, 4139.461869956916, 4141.233871733709, 4154.189932963073, 5783.21926539916, 5787.913181302241, 5792.88414231713, 5796.13058041293, 5796.681182534959, 5377.193420986844, 5492.862678433031, 5497.285352904097, 5497.505224529771, 5497.532709719679, 6451.161349024596, 6456.7740129095255, 6457.225132984072, 6458.095866578683, 6464.030395440722, 4585.72485650862, 4586.610138138262, 4587.7706114694465, 4588.128255631419, 4596.885077873047, 6554.606723596552, 6668.666566671647, 6681.76613818514, 6683.598984060972, 6684.665766711645, 4705.12955103307, 4705.55297246761, 4715.599174070242, 4717.669763116549, 4722.362481065081, 4765.11845308619, 4768.165571025057, 4768.690035147704, 4779.115863565252, 4787.952120478821, 5454.12733962572, 5458.808941687022, 5463.2078348639225, 5471.23402723619, 5479.75341109651, 6326.841828954221, 6471.7734879279, 6530.575512591667, 6539.574927629689, 6564.048213009182, 1659.8506134447957, 1680.1935071165665, 1682.7812384389952, 1683.6127690631224, 1685.1068933465283, 1123.966281011571, 1124.8931351521592, 1128.6783266768932, 1137.556353022322, 1149.0, 6321.0, 6324.588901721373, 6333.36666333363, 6334.398232167937, 6337.302896681362, 6750.291219421988, 6751.966240168767, 6756.932430675631, 6758.3917447428985, 6762.594244345355, 6112.358202388774, 6224.37756224383, 6265.248170219603, 6320.810375688737, 6377.107204991305, 3646.653567911097, 3662.7436079474182, 3686.705063594906, 3690.0774806298427, 3690.2619476104887, 6954.3393377629045, 6959.478039147084, 6975.546589471668, 6975.616341101187, 6976.790696279119, 6735.966320168466, 6905.516613837083, 6922.757703480454, 6938.548994315353, 6960.199577048705, 6919.792406227721, 6975.197852247056, 6983.092198014328, 6991.89512157318, 6994.510384273154, 6804.387605115563, 6809.693563789542, 6810.284920083518, 6813.591184528944, 6832.248452670103, 6512.902306465501, 6697.397234248941, 6728.360805723449, 6744.325567443217, 6745.25802161752, 6940.583564986117, 6971.407430368476, 6975.0, 6978.68595913175, 6984.161900571964, 4701.224297990793, 4739.834105806281, 4740.407449068866, 4741.596964257938, 4747.810087596596, 6681.231658359156, 6795.1845778506895, 6801.591904485746, 6806.455483561204, 6808.727650894107, 6630.469562434897, 6637.800865974028, 6638.50211234169, 6638.966805165944, 6648.401643852077, 6504.1219435375615, 6613.867722645617, 6625.602463852184, 6629.105070815571, 6635.170603674541, 6486.708098135501, 6507.251666058464, 6512.120863683342, 6520.641364724986, 6523.054157147092, 6572.441342485751, 6613.834654133685, 6633.800985970429, 6635.469162467088, 6640.0, 6365.649889256136, 6471.126397936218, 6489.448396886129, 6497.480201583768, 6501.44737697301], "unit": "ms", "name": "prototype.html", "value": 4954.313994783281}, {"lowerIsBetter": false, "replicates": [825.4098319701415, 884.1114679746853, 892.9732108036761, 901.6168128545366, 906.8685040669098, 12995.2202867828, 13262.13796103255, 13278.136921100122, 13285.667858303535, 13305.667358316035, 12769.297688627123, 12848.871511284884, 12919.547815826449, 12945.870541294584, 12975.221486710803, 739.8668239716849, 750.3134631811913, 857.0700789643245, 860.1914200651368, 875.3959767760225, 870.6647940542905, 877.0002197494829, 877.368294827723, 877.4384393987852, 878.0999475537561, 782.6360742254878, 922.8154369126169, 927.332320729074, 928.6563971330584, 929.1637526226416, 779.228563721914, 886.8669699545087, 898.4564338575166, 899.5861903524386, 901.1709227510706, 669.6082791566939, 669.9363560461749, 670.0184230102874, 670.4401824476568, 670.8121725916702, 12038.458269377812, 12110.15228933975, 12114.273143611323, 12129.5148194073, 12323.69190770229, 12014.519419223221, 12281.877181228163, 12506.437210325466, 12517.186382885084, 13002.219866808022, 10356.637517686844, 10521.894781052168, 10710.732231694192, 10731.409772462512, 10780.15883712457, 3729.850805967758, 3828.425736139601, 3833.1375440525658, 3833.750806197588, 3843.8846834595006, 49394.75302623464, 49589.25616115725, 50557.0, 51222.48777512214, 51307.74346128246, 8566.657333706706, 8613.784655383666, 8637.309015278763, 8638.17937295956, 8716.389852710376, 16225.59436014109, 16235.107069111313, 16265.430709925096, 16286.429974950819, 16290.755638665429, 7274.27257274279, 7742.535447873146, 7774.727884524014, 7813.570253636105, 7977.401694872908, 4170.270202714573, 4205.3271476563605, 4328.372386004012, 4378.43080399546, 4387.758673272937, 3209.6148462184688, 3221.935561288761, 3241.967580324214, 3255.169931667457, 3266.7223286020953, 557.3840905799115, 572.2559977784206, 581.0209796492923, 583.775246530089, 587.5182350472656, 526.541908539573, 626.8526896179394, 648.060312546809, 648.7515995595654, 666.7297850817972, 8541.95729021351, 8961.910380896108, 9063.456192628464, 9368.718938431857, 9710.320277580642, 531.5588061908684, 582.7727186397309, 668.2582333609689, 685.2530741491798, 715.8174665460274, 4049.7570145791346, 4104.91790164195, 4268.2530557152995, 4344.500382455994, 4361.214981303396, 60476.0, 61348.69325653343, 61508.0, 62728.68635656792, 62829.68585157045, 49895.75052124716, 50074.499255007715, 50254.49745502498, 50412.49587504078, 53675.73162134243, 49228.26157607639, 49539.25691114636, 49624.75187624111, 49649.255261171114, 49961.50038499641, 8475.618597163266, 8623.310135189295, 8798.12018798115, 8807.471551706662, 8828.293736500937, 36312.4553131698, 36794.26411471702, 37367.43948840715, 37915.81042094772, 38273.61726382701, 44014.0, 48533.27200092072, 49249.50750492449, 49524.25713614371, 49583.504164957885, 10459.790804184026, 10640.574377024832, 11150.219484635998, 11244.381559014333, 11444.599439019927, 11960.58137965167, 12285.815712764137, 12447.688807779878, 12561.0, 12928.095033347576, 11367.658970230907, 11571.942140289244, 11610.24533405326, 11647.708807279885, 11910.702232444259, 9977.301588888708, 11150.944245278723, 11342.0, 11357.148213883827, 11466.77066458683, 10190.43952582615, 11262.662120136409, 11318.4906679198, 11349.54601815918, 12169.452374643339, 9390.859137113086, 9927.602895884083, 10206.438645874252, 10256.38461692301, 10540.841887371542, 9773.364731292444, 10058.396496210251, 10221.182305415698, 10259.435731034864, 10261.84607230907], "unit": "ms", "name": "yui.html", "value": 6416.063586256515}], "name": "dromaeo_css", "value": 7343.4791741123045}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 102.0, 107.0, 108.0, 110.0, 99.0, 109.0, 107.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 106.5}, {"lowerIsBetter": true, "replicates": [147.0, 121.0, 156.0, 164.0, 124.0, 149.0, 145.0, 121.0, 158.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [70.0, 77.0, 71.0, 150.0, 71.0, 71.0, 70.0, 71.0, 156.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 134.0, 92.0, 92.0, 93.0, 134.0, 91.0, 92.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 58.0, 57.0, 59.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 84.0, 78.0, 79.0, 78.0, 86.0, 77.0, 78.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 110.0, 115.0, 113.0, 111.0, 128.0, 112.0, 113.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [137.0, 137.0, 144.0, 144.0, 155.0, 138.0, 143.0, 146.0, 142.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 63.0, 65.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1473.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.0578114246387], "unit": "score", "name": "Richards", "value": 205.17522399999996}, {"lowerIsBetter": false, "replicates": [170.44486108743823], "unit": "score", "name": "DeltaBlue", "value": 387.91430599999984}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5112.244897959184], "unit": "score", "name": "Decrypt", "value": 52.067341317365305}, {"lowerIsBetter": false, "replicates": [950.5703422053232], "unit": "score", "name": "RayTrace", "value": 778.4684279999997}, {"lowerIsBetter": false, "replicates": [542.0054200542005], "unit": "score", "name": "Earley", "value": 1229.624235}, {"lowerIsBetter": false, "replicates": [10547.368421052632], "unit": "score", "name": "Boyer", "value": 63.187609780439146}, {"lowerIsBetter": false, "replicates": [24119.04761904762], "unit": "score", "name": "RegExp", "value": 37.77035538005923}, {"lowerIsBetter": false, "replicates": [526.592943654555], "unit": "score", "name": "Splay", "value": 154.75140899999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23183.333289080863}]} 06:10:29 INFO - RETURN: dromaeo_css: 7343.48 06:10:29 INFO - RETURN: kraken: 1473.60 06:10:29 INFO - RETURN: v8_7: 23183.33 06:10:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23183.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7343.48"}}} 06:10:29 INFO - Return code: 0 06:10:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:10:29 INFO - # TBPL SUCCESS # 06:10:29 INFO - Running post-action listener: _resource_record_post_action 06:10:29 INFO - Running post-run listener: _resource_record_post_run 06:10:30 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 8192; Write bytes: 503775232; Read time: 556; Write time: 610992 06:10:30 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 239300608; Read time: 224; Write time: 411684 06:10:30 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264474624; Read time: 332; Write time: 199308 06:10:30 INFO - Running post-run listener: _upload_blobber_files 06:10:30 INFO - Blob upload gear active. 06:10:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:10:30 INFO - Copying logs to upload dir... 06:10:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.629494 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-06 06:10:29.268436) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-06 06:10:29.272267) ========= 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454757456/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-06 06:10:29.331144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 06:10:29.331630) ========= 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=f919189b672bc2eeae365d21000001d6-1454766574.45755-1197745259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 06:10:29.381823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 06:10:29.382326) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 06:10:29.382784) ========= ========= Total master_lag: 0.29 =========