builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1455115772.69 results: success (0) buildid: 20160210042720 builduid: b65ac32d7d304e1fb627a240cd2c7d9a revision: 12c978de66eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.687287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.687851) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.688153) ========= 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006324 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.712579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.712889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.729652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.729970) ========= 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.934995) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.935389) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.935762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:32.936058) ========= 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 06:49:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.0M=0s 2016-02-10 06:49:33 (77.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130032 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.083012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.083360) ========= 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015330 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.132918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.133236) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 12c978de66eb --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 12c978de66eb --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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 06:49:33,514 Setting DEBUG logging. 2016-02-10 06:49:33,514 attempt 1/10 2016-02-10 06:49:33,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/12c978de66eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 06:49:33,813 unpacking tar archive at: mozilla-beta-12c978de66eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588644 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.734899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.735287) ========= echo 12c978de66eb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'12c978de66eb'] 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12c978de66eb program finished with exit code 0 elapsedTime=0.004848 script_repo_revision: '12c978de66eb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.787583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.788063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 06:49:33.801122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-10 06:49:33.801795) ========= /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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:34 INFO - MultiFileLogger online at 20160210 06:49:34 in /builds/slave/test-pgo 06:49:34 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 06:49:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:49:34 INFO - {'append_to_log': False, 06:49:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:49:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:49:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:49:34 INFO - 'branch': 'Mozilla-Beta', 06:49:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:34 INFO - 'config_files': ('talos/linux_config.py',), 06:49:34 INFO - 'default_actions': ('clobber', 06:49:34 INFO - 'read-buildbot-config', 06:49:34 INFO - 'download-and-extract', 06:49:34 INFO - 'populate-webroot', 06:49:34 INFO - 'create-virtualenv', 06:49:34 INFO - 'install', 06:49:34 INFO - 'run-tests'), 06:49:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:34 INFO - 'download_minidump_stackwalk': True, 06:49:34 INFO - 'download_symbols': 'ondemand', 06:49:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:34 INFO - 'installer_path': 'installer.exe', 06:49:34 INFO - 'log_level': 'info', 06:49:34 INFO - 'log_name': 'talos', 06:49:34 INFO - 'log_to_console': True, 06:49:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:34 INFO - 'opt_config_files': (), 06:49:34 INFO - 'pip_index': False, 06:49:34 INFO - 'sps_profile': False, 06:49:34 INFO - 'sps_profile_interval': 0, 06:49:34 INFO - 'suite': 'dromaeojs', 06:49:34 INFO - 'system_bits': '32', 06:49:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:34 INFO - 'title': 'talos-linux64-ix-002', 06:49:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:34 INFO - 'use_talos_json': True, 06:49:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:49:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:34 INFO - 'work_dir': 'build'} 06:49:34 INFO - ##### 06:49:34 INFO - ##### Running clobber step. 06:49:34 INFO - ##### 06:49:34 INFO - Running pre-action listener: _resource_record_pre_action 06:49:34 INFO - Running main action method: clobber 06:49:34 INFO - rmtree: /builds/slave/test-pgo/build 06:49:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:49:35 INFO - Running post-action listener: _resource_record_post_action 06:49:35 INFO - ##### 06:49:35 INFO - ##### Running read-buildbot-config step. 06:49:35 INFO - ##### 06:49:35 INFO - Running pre-action listener: _resource_record_pre_action 06:49:35 INFO - Running main action method: read_buildbot_config 06:49:35 INFO - Using buildbot properties: 06:49:35 INFO - { 06:49:35 INFO - "properties": { 06:49:35 INFO - "buildnumber": 114, 06:49:35 INFO - "product": "firefox", 06:49:35 INFO - "script_repo_revision": "production", 06:49:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:49:35 INFO - "repository": "", 06:49:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:49:35 INFO - "buildid": "20160210042720", 06:49:35 INFO - "slavename": "talos-linux64-ix-002", 06:49:35 INFO - "pgo_build": "True", 06:49:35 INFO - "basedir": "/builds/slave/test-pgo", 06:49:35 INFO - "project": "", 06:49:35 INFO - "platform": "ubuntu64_hw", 06:49:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:49:35 INFO - "slavebuilddir": "test", 06:49:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:49:35 INFO - "branch": "mozilla-beta", 06:49:35 INFO - "repo_path": "releases/mozilla-beta", 06:49:35 INFO - "stage_platform": "linux64-pgo", 06:49:35 INFO - "builduid": "b65ac32d7d304e1fb627a240cd2c7d9a", 06:49:35 INFO - "revision": "12c978de66eb" 06:49:35 INFO - }, 06:49:35 INFO - "sourcestamp": { 06:49:35 INFO - "repository": "", 06:49:35 INFO - "hasPatch": false, 06:49:35 INFO - "project": "", 06:49:35 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 06:49:35 INFO - "changes": [ 06:49:35 INFO - { 06:49:35 INFO - "category": null, 06:49:35 INFO - "files": [ 06:49:35 INFO - { 06:49:35 INFO - "url": null, 06:49:35 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2" 06:49:35 INFO - } 06:49:35 INFO - ], 06:49:35 INFO - "repository": "", 06:49:35 INFO - "rev": "12c978de66eb", 06:49:35 INFO - "who": "sendchange", 06:49:35 INFO - "when": 1455115720, 06:49:35 INFO - "number": 7588058, 06:49:35 INFO - "comments": "Bug 1233046 - Mark non-try platforms. r=jmuizelaar, a=sylvestre", 06:49:35 INFO - "project": "", 06:49:35 INFO - "at": "Wed 10 Feb 2016 06:48:40", 06:49:35 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 06:49:35 INFO - "revlink": "", 06:49:35 INFO - "properties": [ 06:49:35 INFO - [ 06:49:35 INFO - "buildid", 06:49:35 INFO - "20160210042720", 06:49:35 INFO - "Change" 06:49:35 INFO - ], 06:49:35 INFO - [ 06:49:35 INFO - "builduid", 06:49:35 INFO - "b65ac32d7d304e1fb627a240cd2c7d9a", 06:49:35 INFO - "Change" 06:49:35 INFO - ], 06:49:35 INFO - [ 06:49:35 INFO - "pgo_build", 06:49:35 INFO - "True", 06:49:35 INFO - "Change" 06:49:35 INFO - ] 06:49:35 INFO - ], 06:49:35 INFO - "revision": "12c978de66eb" 06:49:35 INFO - } 06:49:35 INFO - ], 06:49:35 INFO - "revision": "12c978de66eb" 06:49:35 INFO - } 06:49:35 INFO - } 06:49:35 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2. 06:49:35 INFO - Running post-action listener: _resource_record_post_action 06:49:35 INFO - ##### 06:49:35 INFO - ##### Running download-and-extract step. 06:49:35 INFO - ##### 06:49:35 INFO - Running pre-action listener: _resource_record_pre_action 06:49:35 INFO - Running main action method: download_and_extract 06:49:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/test_packages.json 06:49:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:49:35 INFO - Downloaded 1270 bytes. 06:49:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:49:35 INFO - Using the following test package requirements: 06:49:35 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 06:49:35 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:35 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'jsshell-linux-x86_64.zip'], 06:49:35 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:35 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 06:49:35 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 06:49:35 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 06:49:35 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:35 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 06:49:35 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:49:35 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:35 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:49:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:35 INFO - Downloaded 21581705 bytes. 06:49:35 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 06:49:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:49:35 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 06:49:36 INFO - Return code: 0 06:49:36 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 06: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')]} 06:49:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:49:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:37 INFO - Downloaded 21581705 bytes. 06: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 06:49:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06: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 06:49:38 INFO - Return code: 0 06: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')]} 06:49:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 06:49:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:38 INFO - Downloaded 11132038 bytes. 06:49:38 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 06:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 06:49:38 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 06:49:39 INFO - Return code: 0 06:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:49:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/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 06:49:40 INFO - Downloaded 57949024 bytes. 06:49:40 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:49:40 INFO - mkdir: /builds/slave/test-pgo/properties 06:49:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:49:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:49:40 INFO - Contents: 06:49:40 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - Running post-action listener: set_extra_try_arguments 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running populate-webroot step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: populate_webroot 06:49:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:40 INFO - '--tppagecycles', 06:49:40 INFO - '7'], 06:49:40 INFO - 'tests': ['tsvgm']}}, 06:49:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:49:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:49:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'tests': ['damp', 'tps']}, 06:49:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['damp', 'tps']}, 06:49:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:49:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:40 INFO - 'other': {'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore']}, 06:49:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore']}, 06:49:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore']}, 06:49:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore']}, 06:49:40 INFO - 'other_l64': {'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore']}, 06:49:40 INFO - 'other_nol64': {'tests': ['a11yr', 06:49:40 INFO - 'ts_paint', 06:49:40 INFO - 'tpaint', 06:49:40 INFO - 'sessionrestore', 06:49:40 INFO - 'sessionrestore_no_auto_restore']}, 06:49:40 INFO - 'svgr': {'tests': ['tsvgx', 06:49:40 INFO - 'tsvgr_opacity', 06:49:40 INFO - 'tart', 06:49:40 INFO - 'tscrollx', 06:49:40 INFO - 'cart']}, 06:49:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['tsvgx', 06:49:40 INFO - 'tsvgr_opacity', 06:49:40 INFO - 'tart', 06:49:40 INFO - 'tscrollx', 06:49:40 INFO - 'cart']}, 06:49:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'tests': ['tp5o']}, 06:49:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--e10s'], 06:49:40 INFO - 'tests': ['tp5o']}, 06:49:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--xperf_path', 06:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:40 INFO - 'tests': ['tp5n']}, 06:49:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:40 INFO - 'talos_options': ['--e10s', 06:49:40 INFO - '--xperf_path', 06:49:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:40 INFO - 'tests': ['tp5n']}}, 06:49:40 INFO - 'talos.zip': {'path': '', 06:49:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:40 INFO - Running post-action listener: _resource_record_post_action 06:49:40 INFO - ##### 06:49:40 INFO - ##### Running create-virtualenv step. 06:49:40 INFO - ##### 06:49:40 INFO - Running pre-action listener: _resource_record_pre_action 06:49:40 INFO - Running main action method: create_virtualenv 06:49:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:49:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:49:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:49:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:40 INFO - Using real prefix '/usr' 06:49:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:49:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:43 INFO - Installing pip.................done. 06:49:43 INFO - Return code: 0 06:49:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:43 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 06:49:43 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 06:49:43 INFO - Using env: {'DISPLAY': ':0', 06:49:43 INFO - 'HOME': '/home/cltbld', 06:49:43 INFO - 'LANG': 'en_US.UTF-8', 06:49:43 INFO - 'LANGUAGE': 'en_US:en', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MAIL': '/var/mail/cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SHLVL': '1', 06:49:43 INFO - 'TERM': 'linux', 06:49:43 INFO - 'TMOUT': '86400', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - '_': '/tools/buildbot/bin/python'} 06:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:49:43 INFO - Cleaning up... 06:49:43 INFO - Return code: 0 06:49:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:43 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:43 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 06:49:43 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 06:49:43 INFO - Using env: {'DISPLAY': ':0', 06:49:43 INFO - 'HOME': '/home/cltbld', 06:49:43 INFO - 'LANG': 'en_US.UTF-8', 06:49:43 INFO - 'LANGUAGE': 'en_US:en', 06:49:43 INFO - 'LOGNAME': 'cltbld', 06:49:43 INFO - 'MAIL': '/var/mail/cltbld', 06:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:43 INFO - 'MOZ_NO_REMOTE': '1', 06:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:43 INFO - 'NO_EM_RESTART': '1', 06:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:43 INFO - 'SHELL': '/bin/bash', 06:49:43 INFO - 'SHLVL': '1', 06:49:43 INFO - 'TERM': 'linux', 06:49:43 INFO - 'TMOUT': '86400', 06:49:43 INFO - 'USER': 'cltbld', 06:49:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:43 INFO - '_': '/tools/buildbot/bin/python'} 06:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:43 INFO - Downloading/unpacking psutil>=0.7.1 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:45 INFO - Installing collected packages: psutil 06:49:45 INFO - Running setup.py install for psutil 06:49:45 INFO - building 'psutil._psutil_linux' extension 06:49:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:49:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:49:45 INFO - building 'psutil._psutil_posix' extension 06:49:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:49:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:49:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:45 INFO - Successfully installed psutil 06:49:45 INFO - Cleaning up... 06:49:45 INFO - Return code: 0 06:49:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:45 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:45 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 06:49:45 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 06:49:45 INFO - Using env: {'DISPLAY': ':0', 06:49:45 INFO - 'HOME': '/home/cltbld', 06:49:45 INFO - 'LANG': 'en_US.UTF-8', 06:49:45 INFO - 'LANGUAGE': 'en_US:en', 06:49:45 INFO - 'LOGNAME': 'cltbld', 06:49:45 INFO - 'MAIL': '/var/mail/cltbld', 06:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:45 INFO - 'MOZ_NO_REMOTE': '1', 06:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:45 INFO - 'NO_EM_RESTART': '1', 06:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:45 INFO - 'SHELL': '/bin/bash', 06:49:45 INFO - 'SHLVL': '1', 06:49:45 INFO - 'TERM': 'linux', 06:49:45 INFO - 'TMOUT': '86400', 06:49:45 INFO - 'USER': 'cltbld', 06:49:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:45 INFO - '_': '/tools/buildbot/bin/python'} 06:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:49:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:49:47 INFO - Installing collected packages: mozsystemmonitor 06:49:47 INFO - Running setup.py install for mozsystemmonitor 06:49:48 INFO - Successfully installed mozsystemmonitor 06:49:48 INFO - Cleaning up... 06:49:48 INFO - Return code: 0 06:49:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:48 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:48 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 06:49:48 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 06:49:48 INFO - Using env: {'DISPLAY': ':0', 06:49:48 INFO - 'HOME': '/home/cltbld', 06:49:48 INFO - 'LANG': 'en_US.UTF-8', 06:49:48 INFO - 'LANGUAGE': 'en_US:en', 06:49:48 INFO - 'LOGNAME': 'cltbld', 06:49:48 INFO - 'MAIL': '/var/mail/cltbld', 06:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:48 INFO - 'MOZ_NO_REMOTE': '1', 06:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:48 INFO - 'NO_EM_RESTART': '1', 06:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:48 INFO - 'SHELL': '/bin/bash', 06:49:48 INFO - 'SHLVL': '1', 06:49:48 INFO - 'TERM': 'linux', 06:49:48 INFO - 'TMOUT': '86400', 06:49:48 INFO - 'USER': 'cltbld', 06:49:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:48 INFO - '_': '/tools/buildbot/bin/python'} 06:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:49:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - Downloading docopt-0.6.1.tar.gz 06:49:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:49:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:49:50 INFO - Running setup.py install for blobuploader 06:49:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:49:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:49:50 INFO - Running setup.py install for requests 06:49:51 INFO - Running setup.py install for docopt 06:49:51 INFO - Successfully installed blobuploader requests docopt 06:49:51 INFO - Cleaning up... 06:49:51 INFO - Return code: 0 06:49:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:51 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:51 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 06:49:51 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 06:49:51 INFO - Using env: {'DISPLAY': ':0', 06:49:51 INFO - 'HOME': '/home/cltbld', 06:49:51 INFO - 'LANG': 'en_US.UTF-8', 06:49:51 INFO - 'LANGUAGE': 'en_US:en', 06:49:51 INFO - 'LOGNAME': 'cltbld', 06:49:51 INFO - 'MAIL': '/var/mail/cltbld', 06:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:51 INFO - 'MOZ_NO_REMOTE': '1', 06:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:51 INFO - 'NO_EM_RESTART': '1', 06:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:51 INFO - 'SHELL': '/bin/bash', 06:49:51 INFO - 'SHLVL': '1', 06:49:51 INFO - 'TERM': 'linux', 06:49:51 INFO - 'TMOUT': '86400', 06:49:51 INFO - 'USER': 'cltbld', 06:49:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:51 INFO - '_': '/tools/buildbot/bin/python'} 06:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:49:51 INFO - Running setup.py (path:/tmp/pip-XqsLH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:49:51 INFO - Running setup.py (path:/tmp/pip-N02c5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:49:51 INFO - Running setup.py (path:/tmp/pip-9dq4tX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:49:51 INFO - Running setup.py (path:/tmp/pip-ZQAgRt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:49:51 INFO - Running setup.py (path:/tmp/pip-nsklaq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:49:52 INFO - Running setup.py (path:/tmp/pip-4X0Jg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:49:52 INFO - Running setup.py (path:/tmp/pip-ONw3im-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:49:52 INFO - Running setup.py (path:/tmp/pip-bvwY8U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:49:52 INFO - Running setup.py (path:/tmp/pip-BSGKuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:49:52 INFO - Running setup.py (path:/tmp/pip-6nW3oW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:49:52 INFO - Running setup.py (path:/tmp/pip-wMVG0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:49:52 INFO - Running setup.py (path:/tmp/pip-z72iPo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:49:52 INFO - Running setup.py (path:/tmp/pip-IajZQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:49:52 INFO - Running setup.py (path:/tmp/pip-V72O3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:49:52 INFO - Running setup.py (path:/tmp/pip-D__wjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:49:52 INFO - Running setup.py (path:/tmp/pip-qXvDUC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:49:52 INFO - Running setup.py (path:/tmp/pip-R7oLIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:49:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:49:52 INFO - Running setup.py install for manifestparser 06:49:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Running setup.py install for mozcrash 06:49:53 INFO - Running setup.py install for mozdebug 06:49:53 INFO - Running setup.py install for mozdevice 06:49:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Running setup.py install for mozfile 06:49:53 INFO - Running setup.py install for mozhttpd 06:49:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Running setup.py install for mozinfo 06:49:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Running setup.py install for mozInstall 06:49:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Running setup.py install for mozleak 06:49:53 INFO - Running setup.py install for mozlog 06:49:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:49:53 INFO - Running setup.py install for moznetwork 06:49:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:49:54 INFO - Running setup.py install for mozprocess 06:49:54 INFO - Running setup.py install for mozprofile 06:49:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:49:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:49:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:49:54 INFO - Running setup.py install for mozrunner 06:49:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:49:54 INFO - Running setup.py install for mozscreenshot 06:49:54 INFO - Running setup.py install for moztest 06:49:54 INFO - Running setup.py install for mozversion 06:49:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:49:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:49:54 INFO - Cleaning up... 06:49:54 INFO - Return code: 0 06:49:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:54 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:54 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 06:49:54 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 06:49:54 INFO - Using env: {'DISPLAY': ':0', 06:49:54 INFO - 'HOME': '/home/cltbld', 06:49:54 INFO - 'LANG': 'en_US.UTF-8', 06:49:54 INFO - 'LANGUAGE': 'en_US:en', 06:49:54 INFO - 'LOGNAME': 'cltbld', 06:49:54 INFO - 'MAIL': '/var/mail/cltbld', 06:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:54 INFO - 'MOZ_NO_REMOTE': '1', 06:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:54 INFO - 'NO_EM_RESTART': '1', 06:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:54 INFO - 'SHELL': '/bin/bash', 06:49:54 INFO - 'SHLVL': '1', 06:49:54 INFO - 'TERM': 'linux', 06:49:54 INFO - 'TMOUT': '86400', 06:49:54 INFO - 'USER': 'cltbld', 06:49:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:54 INFO - '_': '/tools/buildbot/bin/python'} 06:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:49:54 INFO - Running setup.py (path:/tmp/pip-5dUQuh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:49:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:49:54 INFO - Running setup.py (path:/tmp/pip-eKKZsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06: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)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:49:55 INFO - Running setup.py (path:/tmp/pip-d6GJ3A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06: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)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:49:55 INFO - Running setup.py (path:/tmp/pip-JElTqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:49:55 INFO - Running setup.py (path:/tmp/pip-14ccqz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:49:55 INFO - Running setup.py (path:/tmp/pip-YFUp5c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:49:55 INFO - Running setup.py (path:/tmp/pip-297vwm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:49:55 INFO - Running setup.py (path:/tmp/pip-smlR0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:49:55 INFO - Running setup.py (path:/tmp/pip-0A_V_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:49:55 INFO - Running setup.py (path:/tmp/pip-4amnjS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:49:55 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)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:49:55 INFO - Running setup.py (path:/tmp/pip-_1vlPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:49:55 INFO - Running setup.py (path:/tmp/pip-FBY_dR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:49:55 INFO - Running setup.py (path:/tmp/pip-DxgRoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:49:55 INFO - Running setup.py (path:/tmp/pip-Ybg0oM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:49:55 INFO - Running setup.py (path:/tmp/pip-MIbSNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:49:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:49:55 INFO - Running setup.py (path:/tmp/pip-2009yT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06: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)) 06:49:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:49:56 INFO - Running setup.py (path:/tmp/pip-0dGSsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:49:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:57 INFO - Downloading blessings-1.6.tar.gz 06:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:49:57 INFO - Installing collected packages: blessings 06:49:57 INFO - Running setup.py install for blessings 06:49:58 INFO - Successfully installed blessings 06:49:58 INFO - Cleaning up... 06:49:58 INFO - Return code: 0 06:49:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:49:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:49:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:49:58 INFO - Reading from file tmpfile_stdout 06:49:58 INFO - Current package versions: 06:49:58 INFO - argparse == 1.2.1 06:49:58 INFO - blessings == 1.6 06:49:58 INFO - blobuploader == 1.2.4 06:49:58 INFO - docopt == 0.6.1 06:49:58 INFO - manifestparser == 1.1 06:49:58 INFO - mozInstall == 1.12 06:49:58 INFO - mozcrash == 0.16 06:49:58 INFO - mozdebug == 0.1 06:49:58 INFO - mozdevice == 0.47 06:49:58 INFO - mozfile == 1.2 06:49:58 INFO - mozhttpd == 0.7 06:49:58 INFO - mozinfo == 0.9 06:49:58 INFO - mozleak == 0.1 06:49:58 INFO - mozlog == 3.1 06:49:58 INFO - moznetwork == 0.27 06:49:58 INFO - mozprocess == 0.22 06:49:58 INFO - mozprofile == 0.27 06:49:58 INFO - mozrunner == 6.11 06:49:58 INFO - mozscreenshot == 0.1 06:49:58 INFO - mozsystemmonitor == 0.0 06:49:58 INFO - moztest == 0.7 06:49:58 INFO - mozversion == 1.4 06:49:58 INFO - psutil == 3.1.1 06:49:58 INFO - requests == 1.2.3 06:49:58 INFO - wsgiref == 0.1.2 06:49:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:58 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 06:49:58 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 06:49:58 INFO - Using env: {'DISPLAY': ':0', 06:49:58 INFO - 'HOME': '/home/cltbld', 06:49:58 INFO - 'LANG': 'en_US.UTF-8', 06:49:58 INFO - 'LANGUAGE': 'en_US:en', 06:49:58 INFO - 'LOGNAME': 'cltbld', 06:49:58 INFO - 'MAIL': '/var/mail/cltbld', 06:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:58 INFO - 'MOZ_NO_REMOTE': '1', 06:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:58 INFO - 'NO_EM_RESTART': '1', 06:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:58 INFO - 'SHELL': '/bin/bash', 06:49:58 INFO - 'SHLVL': '1', 06:49:58 INFO - 'TERM': 'linux', 06:49:58 INFO - 'TMOUT': '86400', 06:49:58 INFO - 'USER': 'cltbld', 06:49:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:58 INFO - '_': '/tools/buildbot/bin/python'} 06:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:49:58 INFO - Cleaning up... 06:49:58 INFO - Return code: 0 06:49:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:58 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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:49:58 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 06:49:58 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 06:49:58 INFO - Using env: {'DISPLAY': ':0', 06:49:58 INFO - 'HOME': '/home/cltbld', 06:49:58 INFO - 'LANG': 'en_US.UTF-8', 06:49:58 INFO - 'LANGUAGE': 'en_US:en', 06:49:58 INFO - 'LOGNAME': 'cltbld', 06:49:58 INFO - 'MAIL': '/var/mail/cltbld', 06:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:58 INFO - 'MOZ_NO_REMOTE': '1', 06:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:49:58 INFO - 'NO_EM_RESTART': '1', 06:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:49:58 INFO - 'SHELL': '/bin/bash', 06:49:58 INFO - 'SHLVL': '1', 06:49:58 INFO - 'TERM': 'linux', 06:49:58 INFO - 'TMOUT': '86400', 06:49:58 INFO - 'USER': 'cltbld', 06:49:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:58 INFO - '_': '/tools/buildbot/bin/python'} 06:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:58 INFO - Downloading/unpacking jsonschema 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:00 INFO - warning: no files found matching '*.txt' 06:50:00 INFO - no previously-included directories found matching 'build' 06:50:00 INFO - no previously-included directories found matching 'dist' 06:50:00 INFO - no previously-included directories found matching '.git*' 06:50:00 INFO - Installing collected packages: jsonschema, functools32 06:50:00 INFO - Running setup.py install for functools32 06:50:00 INFO - warning: no files found matching '*.txt' 06:50:00 INFO - no previously-included directories found matching 'build' 06:50:00 INFO - no previously-included directories found matching 'dist' 06:50:00 INFO - no previously-included directories found matching '.git*' 06:50:01 INFO - Successfully installed jsonschema functools32 06:50:01 INFO - Cleaning up... 06:50:01 INFO - Return code: 0 06:50:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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 0x7f60c9db1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x164d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x171a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06: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 06: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 06:50:01 INFO - Using env: {'DISPLAY': ':0', 06:50:01 INFO - 'HOME': '/home/cltbld', 06:50:01 INFO - 'LANG': 'en_US.UTF-8', 06:50:01 INFO - 'LANGUAGE': 'en_US:en', 06:50:01 INFO - 'LOGNAME': 'cltbld', 06:50:01 INFO - 'MAIL': '/var/mail/cltbld', 06:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:01 INFO - 'MOZ_NO_REMOTE': '1', 06:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:01 INFO - 'NO_EM_RESTART': '1', 06:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:01 INFO - 'SHELL': '/bin/bash', 06:50:01 INFO - 'SHLVL': '1', 06:50:01 INFO - 'TERM': 'linux', 06:50:01 INFO - 'TMOUT': '86400', 06:50:01 INFO - 'USER': 'cltbld', 06:50:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:01 INFO - '_': '/tools/buildbot/bin/python'} 06:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:01 INFO - Downloading/unpacking flake8 06: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 06: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 06: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 06: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 06: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 06: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 06:50:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:50:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06: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 06: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 06: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 06: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 06: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 06: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 06:50:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:50:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06: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 06: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 06: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 06: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 06: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 06: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 06:50:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06: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 06: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 06: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 06: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 06: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 06: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 06:50:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:03 INFO - no previously-included directories found matching 'docs/_build' 06:50:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:50:03 INFO - Running setup.py install for pep8 06:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:50:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:50:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:50:03 INFO - no previously-included directories found matching 'docs/_build' 06:50:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:50:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:50:04 INFO - Cleaning up... 06:50:04 INFO - Return code: 0 06:50:04 INFO - Running post-action listener: _resource_record_post_action 06:50:04 INFO - Running post-action listener: _start_resource_monitoring 06:50:04 INFO - Starting resource monitoring. 06:50:04 INFO - ##### 06:50:04 INFO - ##### Running install step. 06:50:04 INFO - ##### 06:50:04 INFO - Running pre-action listener: _resource_record_pre_action 06:50:04 INFO - Running main action method: install 06:50:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:50:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:50:04 INFO - Reading from file tmpfile_stdout 06:50:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:50:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:50:04 INFO - Reading from file tmpfile_stdout 06:50:04 INFO - Output received: 06:50:04 INFO - Usage: mozinstall [options] installer 06:50:04 INFO - Options: 06:50:04 INFO - -h, --help show this help message and exit 06:50:04 INFO - -d DEST, --destination=DEST 06:50:04 INFO - Directory to install application into. [default: 06:50:04 INFO - "/builds/slave/test-pgo"] 06:50:04 INFO - --app=APP Application being installed. [default: firefox] 06:50:04 INFO - mkdir: /builds/slave/test-pgo/build/application 06:50:04 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'] 06:50:04 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 06:50:18 INFO - Reading from file tmpfile_stdout 06:50:18 INFO - Output received: 06:50:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:50:18 INFO - Running post-action listener: _resource_record_post_action 06:50:18 INFO - ##### 06:50:18 INFO - ##### Running run-tests step. 06:50:18 INFO - ##### 06:50:18 INFO - Running pre-action listener: _resource_record_pre_action 06:50:18 INFO - Running main action method: run_tests 06:50:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:50:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:50:18 INFO - Python 2.7.3 06:50:18 INFO - Return code: 0 06:50:18 INFO - grabbing minidump binary from tooltool 06:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:18 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 0x17a9350>, '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 0x17aa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17aa6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:50:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:50:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:50:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:19 INFO - Return code: 0 06:50:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:50:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:50:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:50:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:50:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:50:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:50:20 INFO - Return code: 0 06: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/1455107240/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06: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/1455107240/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 06:50:20 INFO - Using env: {'DISPLAY': ':0', 06:50:20 INFO - 'HOME': '/home/cltbld', 06:50:20 INFO - 'LANG': 'en_US.UTF-8', 06:50:20 INFO - 'LANGUAGE': 'en_US:en', 06:50:20 INFO - 'LOGNAME': 'cltbld', 06:50:20 INFO - 'MAIL': '/var/mail/cltbld', 06:50:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:20 INFO - 'MOZ_NO_REMOTE': '1', 06:50:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:20 INFO - 'NO_EM_RESTART': '1', 06: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', 06:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:50:20 INFO - 'PWD': '/builds/slave/test-pgo', 06:50:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:50:20 INFO - 'SHELL': '/bin/bash', 06:50:20 INFO - 'SHLVL': '1', 06:50:20 INFO - 'TERM': 'linux', 06:50:20 INFO - 'TMOUT': '86400', 06:50:20 INFO - 'USER': 'cltbld', 06:50:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864', 06:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:20 INFO - '_': '/tools/buildbot/bin/python'} 06: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/1455107240/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 06:50:20 INFO - mozversion INFO | application_buildid: 20160210042720 06:50:20 INFO - mozversion INFO | application_changeset: 12c978de66ebd41d5c5c60b268946039e99d416c 06:50:20 INFO - mozversion INFO | application_display_name: Nightly 06:50:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:20 INFO - mozversion INFO | application_name: Firefox 06:50:20 INFO - mozversion INFO | application_remotingname: firefox 06:50:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:50:20 INFO - mozversion INFO | application_vendor: Mozilla 06:50:20 INFO - mozversion INFO | application_version: 45.0 06:50:20 INFO - mozversion INFO | platform_buildid: 20160210042720 06:50:20 INFO - mozversion INFO | platform_changeset: 12c978de66ebd41d5c5c60b268946039e99d416c 06:50:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:50:20 INFO - mozversion INFO | platform_version: 45.0 06:50:20 INFO - 2016-02-10 06:50:20,324 DEBUG : using testdate: 1455115820 06:50:20 INFO - 2016-02-10 06:50:20,325 DEBUG : actual date: 1455115820 06:50:20 INFO - 2016-02-10 06:50:20,441 INFO : starting webserver on 'localhost:54545' 06:50:20 INFO - 2016-02-10 06:50:20,443 INFO : Starting test suite talos-linux64-ix-002 06:50:20 INFO - 2016-02-10 06:50:20,443 INFO : Starting test dromaeo_css 06:50:20 INFO - 2016-02-10 06:50:20,443 DEBUG : operating with platform_type : linux_ 06:50:20 INFO - 2016-02-10 06:50:20,443 INFO : Initialising browser for dromaeo_css test... 06:50:20 INFO - 2016-02-10 06:50:20,456 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1bUFKD/profile http://localhost:54545/getInfo.html 06:50:24 INFO - 2016-02-10 06:50:24,054 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:50:24 INFO - 2016-02-10 06:50:24,054 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:50:24 INFO - 2016-02-10 06:50:24,054 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:50:24 INFO - 2016-02-10 06:50:24,055 DEBUG : BROWSER_OUTPUT: __metrics 06:50:24 INFO - 2016-02-10 06:50:24,223 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:50:25 INFO - 2016-02-10 06:50:25,361 INFO : Browser initialized. 06:50:25 INFO - 2016-02-10 06:50:25,362 INFO : Running cycle 1/1 for dromaeo_css test... 06:50:25 INFO - 2016-02-10 06:50:25,362 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1bUFKD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:50:37 INFO - 2016-02-10 06:50:37,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 133988352 06:50:37 INFO - 2016-02-10 06:50:37,013 DEBUG : BROWSER_OUTPUT: 06:51:27 INFO - 2016-02-10 06:51:27,802 DEBUG : BROWSER_OUTPUT: 1455115887800 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] 06:53:36 INFO - 2016-02-10 06:53:36,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54545/tests/dromaeo/cssquery-ext.html) 06:53:37 INFO - 2016-02-10 06:53:37,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 233123840 06:53:37 INFO - 2016-02-10 06:53:37,119 DEBUG : BROWSER_OUTPUT: 06:56:39 INFO - 2016-02-10 06:56:39,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/dromaeo/cssquery-ext.html (next: http://localhost:54545/tests/dromaeo/cssquery-jquery.html) 06:56:39 INFO - 2016-02-10 06:56:39,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 218300416 06:56:39 INFO - 2016-02-10 06:56:39,716 DEBUG : BROWSER_OUTPUT: 06:59:41 INFO - 2016-02-10 06:59:41,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54545/tests/dromaeo/cssquery-mootools.html) 06:59:42 INFO - 2016-02-10 06:59:42,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 218054656 06:59:42 INFO - 2016-02-10 06:59:42,078 DEBUG : BROWSER_OUTPUT: 07:02:43 INFO - 2016-02-10 07:02:43,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54545/tests/dromaeo/cssquery-prototype.html) 07:02:44 INFO - 2016-02-10 07:02:44,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 196829184 07:02:44 INFO - 2016-02-10 07:02:44,345 DEBUG : BROWSER_OUTPUT: 07:05:46 INFO - 2016-02-10 07:05:46,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54545/tests/dromaeo/cssquery-yui.html) 07:05:47 INFO - 2016-02-10 07:05:47,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 198217728 07:05:47 INFO - 2016-02-10 07:05:47,402 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/dromaeo/cssquery-yui.html (next: http://localhost:54545/tests/dromaeo/cssquery-dojo.html) 07:08:49 INFO - 2016-02-10 07:08:49,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 240947200 07:08:49 INFO - 2016-02-10 07:08:49,878 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,878 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:08:49 INFO - 2016-02-10 07:08:49,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:08:49 INFO - 2016-02-10 07:08:49,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:08:49 INFO - 2016-02-10 07:08:49,878 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:08:49 INFO - 2016-02-10 07:08:49,879 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3261.1847038240435;3328.7170590499804;3354.1614596350914;3354.966450335496;3372.2412457197124;5428.158635411518;5460.372057213422;5467.261919640848;5470.179473079035;5491.670499770016;5484.533814625752;5487.094629386146;5493.642913210639;5502.58730595206;5508.807191748289;4961.776720047606;5024.899502009957;5054.1660625996665;5054.772535235923;5083.415407228179;4938.16051271283;4979.975100124494;4990.925136122961;5054.064997975368;5060.7722652480725;5063.924041139386;5101.84694459165;5115;5118.6416950813455;5140.228965655144;5023.748812559394;5028.7737051832755;5097.719625420582;5111.284420181178;5113.130767769489;4868.342773725537;4934.8766280843265;4963.975180124113;5041.420236672793;5048.7728052237735;5280.52475277223;5286.392064912546;5296.92054619181;5318.760655770499;5344.893102137974;5682.6306290091425;5924.140999555084;5926.2295901532525;5927.792527261525;5971.313298970587;5869.295684517842;5921.763129474859;6033.577649564532;6053.878922421527;6064.363241859585;5525.751341189656;5530.806421775219;5536.584756143265;5539.335279766454;5550.666959982414;5852.648841069549;6018.097285407224;6020.8259389418645;6028.487578555872;6030.4572588467245;5744.109663002241;5823.242978412779;5904.940950590525;5921.940780592139;5939.930812453714;5995.790147344909;5997.160397544348;6000.609960352563;6004.669743164168;6008.549358798107;5907.1434641976675;5922.585419020714;5932.703364831741;5939.049752039653;5942.227510423617;5677.261955945701;5771.192033115367;5798.449147330997;5864.266966629171;5865.941340586625;4470.709403888737;4489.865304040884;4494.9325760113625;4498.032922921588;4519.412476378116;3974.5826688197903;4041.211963667057;4045.130296986162;4065.4105154752397;4075.1645912587846;5477.4796394342475;5572.414896435897;5593.133064375028;5626.97186514073;5645.23789288449;5904.114382842522;5955.196048533479;5963.224780778558;5965.164876917235;5969.940300597025;5511.559075273968;5604.579656525777;5668;5680.375158732536;5692.203091567184;4964.652474326835;5024.271480635361;5037;5038.017586570583;5061.367329083864;6038.215032045806;6085.36103709113;6093.26880774301;6095.420935011167;6099.2680878294;5671.688057156896;5712.742926568398;5739.5695322850115;5902.291724992857;5934.910976335272;6085.604435711664;6121.571489995836;6130.63216207029;6130.785422510191;6135.662538560422;5844.853878653068;5889.087191485327;5891.469767720754;5903.350631430625;5914.733836977261;5688.77244910199;5789.102689083199;5860.560457965585;5930.406959304035;5979.431953964367;5782.855428614318;5809.331926828469;5813.82558523245;5814.854628634318;5816.360200377871;5817.981853175762;5823.126531020212;5823.767049317979;5827.329857066322;5829.8251052468495;5482.725863706878;5499.395066542597;5569.248151499496;5613.775448981995;5613.90528846871;5797.391273916178;5798.6810725410505;5801.506871915934;5802.796902108406;5820.214271073351;5529.281193444987;5627.268455100811;5628.971855140698;5666.17840413146;5672.801451949162 07:08:49 INFO - 2016-02-10 07:08:49,880 DEBUG : BROWSER_OUTPUT: |1;ext.html;579.6319337220866;624.6314674342138;630.1209812311822;633.2812258087071;700.3766647683559;33960.32079358414;42985.78507107464;43047.35428968568;43354;43360.56639433613;47392.28911566329;47713.522864771345;47777.7611111944;48075.51924480754;48091.03817923639;8066.11272759996;8178.5092894426525;9253.999999999984;9437.056294370577;9447.952760236223;11028.062614677761;11254;11298;11318.20772545922;11330.830037549444;11037.172212084086;11177.608783692573;11179.4969226385;11179.944100279487;11189.048930840889;11069.667909962714;11086.16853735965;11137.777244455106;11166.888331116666;11172.608958686447;10906.945465272702;11031.944840275828;11048.889511104866;11049.17131215154;11066.612668556561;45131.32303015458;45352.3197152043;45409;45456.318155227695;45512.77243613761;3478.0783092480515;3480.3909315869623;3491.8476902622074;3494.982525087358;3568.678818906285;33840.49239261413;34243.6575634243;34300.82849585761;34427.4835877462;34452.65547344519;4295.398644189816;4430.136123455927;4467.620252278561;4490.797914093873;4514.255147900592;303682;305171;305740;305909;307283;60619.696901516094;68563.65718171476;69040;69092.999999999;69144.30855691379;60180.699096505115;60344.39655603388;78254.21745782583;82069.58965205136;82142;17598;17613.823861761473;17789.377371791925;17791.19939602695;17859.196336164903;13736.65658358549;13836.031477796458;13875.444982200599;13885.583432497042;13887.097338672955;22436.66345004826;22557.774422255894;22841.428964275692;22855.771442285695;22909.88545057264;8105.675772969015;8227.794305142419;8338.374621903382;8373.95813020931;8442.957785211034;1069.1820757120809;1075.0432115417284;1084.8318510630866;1113.4989254835357;1231.132051903406;28730.425391492052;29505.852470737507;29973;30732.53901191484;31181.064568062993;972.8686627305365;1118.278710231912;1123.601121601836;1151.5911851292838;1176.9411529423494;14109.71780564383;14785.556433306803;14866.851331486763;16201.108939008232;16468.142459975923;369879;374630;374705;375549;375890;60803.39196607978;60938.69530652319;60962;60983.39016609866;61065.694671526355;1257.6918654929418;1280.2830414967648;1372.979405308921;1374.5944946240884;1377.318227477385;28010.2997425066;28067.298317542223;28719.138425847257;28872.278193045342;29663.85168074146;47487.52512474969;47829.76085119552;47891;53836;54515.45484545104;454463;458148;461234;463904;464443;35508.82245588755;35594.46608300826;36181.27637447184;36192.457113142795;36218;48359;49005;49097.526775858125;49413;49536;39700;40310.596894031856;40330.395044073775;40996.590034099274;41839;41249.76901447885;41386.58613413948;41786;42035.36946945737;47160.52839471561;40817.387739183345;43002.35496467618;43440.34839477347;44218.557814421445;44288;42619.360709588764;44479.332810007225;44703.05496138236;44728;45399.09201815879;33561.66438335683;36114.54676029268;36745.63254367422;36880.44679329758;37186.6281337194 07:08:49 INFO - 2016-02-10 07:08:49,882 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.12835249042143;389.2623478508227;389.4392075411407;389.82652719539817;395.3200495148344;14665.193414362206;17225.655486890286;17382.478525644234;19951.201951921925;19957.201711931524;19266.807331926677;19277;19282.807171928278;19518.21927122917;19544.31594894179;6195.566310358288;6289.842753931142;6327.209098862642;6354.904676429857;6357.205349331333;4609.953900461002;4747.881302967437;6313.053042043684;6827.112475378194;7046.154461464605;5265.368155821307;6948.444124470056;6981.720731170747;7010.053642758214;7024.332688394595;5431.918521222185;5436.836894893159;5449.346078470569;5453.345598528163;5466.863328416802;5251.842444726664;5299.894002119974;5422.674639521641;5431.131019036975;5434.592405569598;13331;13371.665708357368;13591.320433978262;13850.653733656638;13897.374618142208;2157.56848630273;2197.8681279123302;2253.9774602253933;2264.4904896398343;2383.6662867198606;10638.042576168105;10702.304350217211;10756.731081723019;12780.977521798233;13820.170789752647;1982.1674896543486;2003.5892642008353;2007.1670256843393;2017.3040301096098;2053.3839848045677;65488.3451165487;67321.326786732;67405;67441;67961.320386796;11382.487788049557;11389.601363952223;11459.31244125355;11466.197366184288;11571.942140289244;14942.103473791607;14973.925130374279;15001.624959375884;15099.849001510063;15116.54650360491;7976.960115199387;8017.478863873829;8030.9196908031345;8260.628271727786;8263.834723305501;7787.688492460238;7995.560244186509;8013.719519816778;8043.6782528698195;8058.11360750317;4481.910361792811;4881.926771098365;4903.681260718042;4934.309196712463;4972.5276098770555;1735.8298641851968;1898.5633304340079;1934.023318224316;1950.8439324853978;1971.3888694504749;953.6709835106877;996.6960077176386;1015.6343716262139;1083.1443159903745;1114.905233055183;14984.325705343286;16633.83366166323;17014;17298;17892.910535447238;909.5906841921162;971.834788086013;1015.7511409704522;1029.7683021320142;1033.5865653738565;9691.370060946016;10137.93551677078;10302.227332950059;10439.530221140067;10543.209259305582;674894;678898;698515;700480;709309;87260.56369718238;87787;89754.10245897458;89903.10096899078;90631;1210.842590463234;1212.2423485321497;1215.3437143942172;1218.7867123253395;1223.443333283354;16677.33290668408;16710.164491775606;16858.325666973673;16902.40841570539;16975.236114374635;35975.64024359723;36352.27295454129;37126.6287337134;37356.81321593375;37782.43326350052;48779.26831097608;49190;49496;50623.74688126536;51608.22587661263;9923.603055877684;10035;10178;10220.182385409298;10263.948680256552;12067.275963442222;12162.574309899112;14456.710865782416;16539.421120260733;16556.586085347964;15181.772273416129;15632.843671563594;15965.121918294606;15971.760423593423;16172.272247748644;15116.848831511545;15597.220138992778;15817.367305307658;15872.52382428529;16175.191240438166;15566.844331556993;16116.113613751357;16145.838541614903;16461.423850165185;16793.74809377836;10621.415822129857;10640.627578034731;10714.785704285714;10726.410047447465;10747.677569672922;15077.321520531383;15341.539753807403;16036.839631603534;16177.27202275924;16339.264733087277 07:08:49 INFO - 2016-02-10 07:08:49,885 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1514.5077849698848;1574.2679653960909;1619.2632352279713;1767.3725827331298;1907.3896353166992;7753.379729621631;8168.63241154148;8172.673093076285;8182.713605023825;8184.959075204616;7766.922330776691;7806.531608103518;7808.8047798805055;7817.491863028899;7820.726274580391;2308.6421604651305;2321.466062805556;2354.458474550854;2355.705536807899;2356.2460012795914;2171.7936796004356;2197.0662468450923;2198.1537108213292;2198.890055497219;2199.2082850174006;2043.039771307483;2090.5296308330658;2237.4741935645193;2290.770922907704;2302.0561569756405;2144.8927553622334;2168.8373371997163;2191.6274233380364;2193.583219188357;2196.736391632998;2298.069281940817;2327.650852372141;2331.63859601762;2332.650102484624;2333.5916214662534;6870.7595234166565;7015.088038554955;7512.474126811126;7716.189800071024;7716.459847810655;4761.2143996240575;4875.390576177978;4875.53682400175;4875.902481950341;4877.878053048702;2975.1074677596635;3037.9088627340993;3053.0993356959752;3067.4171907337536;3072.078376487067;1041.427215031737;1049.1659130990881;1069.6149386220955;1081.0594782539242;1114.6656003199007;10563.94718026405;10674.839877401846;10679.519421626046;10688.572457101707;10689.946550267277;4143.295639741251;4161.75029498225;4241.406203131564;4245.469316335458;4253.595908388698;8845;8853.601587928559;8862.936447626198;8865;8884.8667269991;4755.0489902019735;4768.1417344878255;4771.73755443447;4771.785269662873;4772.0217355442055;4427.579379958899;4429.047754732684;4429.379886815848;4437.511873693891;4448;3461.9480707789403;3497.842597083137;3497.89506314811;3523.1544429336773;3531.8940431787087;1024.8206563851297;1026.4867566216892;1032.2928793776287;1041.8228901086834;1042.9843552346722;1057.9259451838298;1081.6106201767357;1084;1286.395394164741;1428.7713965765636;7511.51175173612;7558.395328373717;7612.961935190288;7637.389008879276;7823.335016523545;514.3467795899262;515.8658748725359;520.0560981818064;523.9895202095937;533.0298856081894;5753.568482363839;6176.7838125666285;6214.378562143749;6223.253209614875;6223.751049957951;8769.298456123495;9484.810303793885;9492.95253523728;9516.857247141299;9517.23862091031;9182.540872956459;9328.95335523318;9370.10983956523;9391.953040234755;9552.044795520393;7497.250274972568;7519.097708275042;7577.0907491101425;7584.241575842482;7599.202083781234;7465.328120469184;7608.0489938757655;7615.923840761521;7640.885386719093;7673.386129109769;8249.092599814136;8262.256396924306;8297.95851020741;8345.54099524532;8619.655213791379;8743.650253989768;8788.033316335326;8863.468191908507;8900.73297801067;9042.954785226031;7195.280471952763;7267.672954717156;7272;7273.745418910313;7274.781756547312;7826.686932522863;7913.287804097428;7927.960360198393;7940.920590794018;7977.401694872791;7391.963040184764;7494.3629791466155;7497.175310715707;7500.062492188476;7522.097348318237;7247.383972362198;7257.092863392076;7288.489805713549;7307.525010874276;7353.264673532604;7330.816729581803;7385.076865391826;7451.254874512722;7502.737404190827;7503.812404689708;6746.089277947414;6783;6783.084283621845;6783.89824152648;6794.4904132189295;6815.488838337045;6818.113645226089;6876.071730316343;6879.621620810904;6887.2079710831895 07:08:49 INFO - 2016-02-10 07:08:49,885 DEBUG : BROWSER_OUTPUT: |4;prototype.html;356.2092155414981;360.85926488669406;365.64532403568535;367.03835949811497;368.4399712437094;5873.353931067579;5937.495312898403;6035.215421995134;6036.939630603692;6044.486218671407;5869.2369991901;6006.819795406134;6010.789622363218;6018.307894592123;6025.276966763994;4703.270992996074;4717.339572459859;4719.764011799413;4720.763961801913;4722.244440889458;4539.9773001134945;4639.211334073216;4647.349371088034;4654.581087702106;4725.740084295362;4580.1984652685815;4682.6956247843955;4699.318598803172;4706.317583950326;4718.174319494092;4677.976610116962;4678.438587369537;4679.836205732783;4683.274092515666;4683.601893839028;4177.498700156001;4181.790910454465;4183.393407955829;4187.330027195634;4190.979045104786;5614.382417934024;5708.914366284509;5711.971440142815;5714.399988001242;5720;5434.347878254595;5449.945500544984;5456.83629491112;5462.262594549725;5468.26178465906;6108.969455152695;6358.0462930560325;6358.7774427895265;6359.332270111664;6363.968180159116;4453.198424283628;4470.75410852403;4541.386912766768;4544.8863778405475;4557.58981691646;6557.672116394161;6585.308542603006;6590.802275931682;6596.571222870546;6598.47212223021;4666.929996050062;4674.6026587740425;4675.322078298627;4675.742834144155;4677.251639737626;4656.720596764205;4721.858344249678;4724.078804633064;4735.857924262209;4737.763111844394;5375.274337964403;5387.46125387466;5388.9730551347775;5389.51494365509;5401.945980540223;6410;6417.069524918954;6423.261324947691;6428.935710642833;6428.935710642927;1651.4550198434488;1708.6070203853183;1708.7436884467181;1709.726443768991;1712.5119340987758;1111.6109361723331;1124.1512657943201;1125.662301309604;1140.9201355905172;1154.0133186125909;6248.875022499525;6249.875002499924;6254.781082662085;6256.906146407808;6265.279492858289;6610.0745895574655;6610.206775187008;6617.172853393326;6620.470362370998;6621.702023408958;6174.629522228681;6255.749770009149;6258.499320054476;6273.937260627426;6277.5605707600025;3558.893233203008;3599.406097993854;3599.640035996432;3607.4769158471877;3609.855605775792;6913.965430172918;6915.930840691629;6925.722971081201;6926.099607051152;6928.61892595902;6694.9665251674405;6863.965680171667;6872.759453419107;6884.931150688529;6887.586744795329;6854.417374523122;6906.240313565504;6910.239873613898;6912.827179320457;6916.965415172892;6430.7749228776765;6498.415142636996;6563.9343606565235;6664.900026499703;6665.600063996176;6603.966980165068;6606.636634985122;6621.735130594915;6631;6640.203175618956;6869.900815869437;6870.96935459685;6881.621510816954;6898.827529311607;6918.584884906922;4517.277235642281;4600.849787553112;4667.346571479928;4689.132510485571;4690.202665546797;6646.767363142267;6648.501362397743;6650.83372915681;6656.167979002625;6658.500612453989;6473.320301368477;6478.578892371981;6485.837854053498;6488.610683359014;6489.415952564292;6274.717637706223;6474.773382931575;6488.059231411325;6490.578112422678;6491.4806815455595;6329.1139240505445;6341.270753863365;6341.8731625368155;6343.207099112611;6344.175257216532;6542.476601871934;6547.803565893031;6553.442957348679;6553.574017689026;6565.42429816831;6270.278917924315;6379.553431259953;6384.648844313421;6385.87228255423;6395.552311338348 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: |5;yui.html;831.1771346367094;884.204216205415;922.4419226368047;954.9761255968602;956.1346980982214;13721.656958576028;13731.519396821113;13754.793678094837;13776.931115344421;13796.931015344935;13022.088453808237;13036.934815325934;13081.149725267875;13134.277614731185;13135.93432032841;749.108560812634;762.5119923249125;762.523422860712;762.5767698927093;901.5852707754408;904.0462312260562;907.9092090790934;908.0919080919081;910.3309067835169;910.517425764346;956.7082039977804;962.7304354780673;962.7929995051063;965.420747551467;965.6378857928277;785.6346798738614;950.9714708558754;954.2127744610689;958.2094771813212;958.4536814016013;591.4676790888235;700.6426722371627;709.3048812164056;709.9148102227714;710.4777988178685;12830.101892867502;12903;12922.224666520038;12949.870501294961;12949.870501294961;12792.808107878389;12833.230006199658;13934.233617151052;14006.22965736884;14045.508407205802;11474.311541307548;11665.591704290395;11704.356260405675;11822.231554948987;12022.338771367571;3960.148568057881;3980.7810570418615;3997.1805779815068;4035.8587449439424;4128.8348466061325;50385;50468.24297635538;51244;51419.48580514184;51684.483155168346;10469.633562825416;10625.149988000941;10716.93086187775;10801.567937282422;10872;17957;17970;17977.1011449427;17994.100294985197;18051.909740451214;7912;7956.283934445928;7989;8030.879536806952;8062.838743225103;4420.955790442119;4479.977600111979;4578.450585929643;4580.198465268565;4585.79363928624;3302.9174270642948;3314.2211580278617;3324.5511855899144;3339.3488269787645;3339.5992480902446;570.8316046766214;571.5598988778618;577.1112486770411;578.9363170051291;612.0788213738384;677.1941389746187;703.391566295151;729.0437276842349;736.1056316575387;742;8857.557122143868;9281.118293762082;9300.813983720287;9304.348695591243;9327.393719408217;513.5352505982092;612.0757655939564;699.3985172751429;773.1997382708869;792.9960350198328;4162.458880345535;4443.466783985942;4601.372426699938;4708.858734237979;4820.30105634681;57117.14324285139;57287;58351.70824145937;59315;59714.70142649259;52362.73818630882;52674.47325526696;52750.208746868826;53115;55205.895882082135;48271.5172848267;48698.26952595714;49286;51172.74413627983;51614.74192629013;8819.823603527766;9178.770530736785;9269.582868771056;9373.1564159226;9514.666986655433;35977.28045439024;37007.814960925025;37250;37434.62565374311;37681;44038.33942490801;44538;47192.528074718815;48271.5172848267;49726.25410618916;11741.47163377633;11743.119266055252;11944.223625464318;12006.459709312927;12059.939700301442;11996.700082498008;11999.680753421742;12001.459934302802;12079.51681932748;12244.510219591117;11578.76842463163;11653;11763.529458821551;11775.941120294343;12057.276563406223;12126.575569855013;12194.939025304817;12281.078919080926;12370;12526;11493.655190343969;11537.01935335506;11851.348175850411;11853;12271.57049503263;10197.490125493547;10761.031507164393;11011.433071179974;11054.613088541862;11148.275362101438;10202.948985255027;10648.84026739584;10686;10745.677629671123;10784.137269018616 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,721 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: __startTimestamp1455116929876__endTimestamp 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5480.72 Median:5671.69 stddev:608.71 (10.7%) stddev-sans-first:585.15 07:08:49 INFO - 2016-02-10 07:08:49,887 DEBUG : BROWSER_OUTPUT: Values: 3261.2 3328.7 3354.2 3355.0 3372.2 5428.2 5460.4 5467.3 5470.2 5491.7 5484.5 5487.1 5493.6 5502.6 5508.8 4961.8 5024.9 5054.2 5054.8 5083.4 4938.2 4980.0 4990.9 5054.1 5060.8 5063.9 5101.8 5115.0 5118.6 5140.2 5023.7 5028.8 5097.7 5111.3 5113.1 4868.3 4934.9 4964.0 5041.4 5048.8 5280.5 5286.4 5296.9 5318.8 5344.9 5682.6 5924.1 5926.2 5927.8 5971.3 5869.3 5921.8 6033.6 6053.9 6064.4 5525.8 5530.8 5536.6 5539.3 5550.7 5852.6 6018.1 6020.8 6028.5 6030.5 5744.1 5823.2 5904.9 5921.9 5939.9 5995.8 5997.2 6000.6 6004.7 6008.5 5907.1 5922.6 5932.7 5939.0 5942.2 5677.3 5771.2 5798.4 5864.3 5865.9 4470.7 4489.9 4494.9 4498.0 4519.4 3974.6 4041.2 4045.1 4065.4 4075.2 5477.5 5572.4 5593.1 5627.0 5645.2 5904.1 5955.2 5963.2 5965.2 5969.9 5511.6 5604.6 5668.0 5680.4 5692.2 4964.7 5024.3 5037.0 5038.0 5061.4 6038.2 6085.4 6093.3 6095.4 6099.3 5671.7 5712.7 5739.6 5902.3 5934.9 6085.6 6121.6 6130.6 6130.8 6135.7 5844.9 5889.1 5891.5 5903.4 5914.7 5688.8 5789.1 5860.6 5930.4 5979.4 5782.9 5809.3 5813.8 5814.9 5816.4 5818.0 5823.1 5823.8 5827.3 5829.8 5482.7 5499.4 5569.2 5613.8 5613.9 5797.4 5798.7 5801.5 5802.8 5820.2 5529.3 5627.3 5629.0 5666.2 5672.8 07:08:49 INFO - 2016-02-10 07:08:49,888 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,888 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57061.04 Median:205908.31 stddev:101323.98 (49.2%) stddev-sans-first:101519.48 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: Values: 579.6 624.6 630.1 633.3 700.4 33960.3 42985.8 43047.4 43354.0 43360.6 47392.3 47713.5 47777.8 48075.5 48091.0 8066.1 8178.5 9254.0 9437.1 9448.0 11028.1 11254.0 11298.0 11318.2 11330.8 11037.2 11177.6 11179.5 11179.9 11189.0 11069.7 11086.2 11137.8 11166.9 11172.6 10906.9 11031.9 11048.9 11049.2 11066.6 45131.3 45352.3 45409.0 45456.3 45512.8 3478.1 3480.4 3491.8 3495.0 3568.7 33840.5 34243.7 34300.8 34427.5 34452.7 4295.4 4430.1 4467.6 4490.8 4514.3 303682.0 305171.0 305740.0 305909.0 307283.0 60619.7 68563.7 69040.0 69093.0 69144.3 60180.7 60344.4 78254.2 82069.6 82142.0 17598.0 17613.8 17789.4 17791.2 17859.2 13736.7 13836.0 13875.4 13885.6 13887.1 22436.7 22557.8 22841.4 22855.8 22909.9 8105.7 8227.8 8338.4 8374.0 8443.0 1069.2 1075.0 1084.8 1113.5 1231.1 28730.4 29505.9 29973.0 30732.5 31181.1 972.9 1118.3 1123.6 1151.6 1176.9 14109.7 14785.6 14866.9 16201.1 16468.1 369879.0 374630.0 374705.0 375549.0 375890.0 60803.4 60938.7 60962.0 60983.4 61065.7 1257.7 1280.3 1373.0 1374.6 1377.3 28010.3 28067.3 28719.1 28872.3 29663.9 47487.5 47829.8 47891.0 53836.0 54515.5 454463.0 458148.0 461234.0 463904.0 464443.0 35508.8 35594.5 36181.3 36192.5 36218.0 48359.0 49005.0 49097.5 49413.0 49536.0 39700.0 40310.6 40330.4 40996.6 41839.0 41249.8 41386.6 41786.0 42035.4 47160.5 40817.4 43002.4 43440.3 44218.6 44288.0 42619.4 44479.3 44703.1 44728.0 45399.1 33561.7 36114.5 36745.6 36880.4 37186.6 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34094.44 Median:10757.85 stddev:113095.73 (1051.3%) stddev-sans-first:113384.67 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: Values: 389.1 389.3 389.4 389.8 395.3 14665.2 17225.7 17382.5 19951.2 19957.2 19266.8 19277.0 19282.8 19518.2 19544.3 6195.6 6289.8 6327.2 6354.9 6357.2 4610.0 4747.9 6313.1 6827.1 7046.2 5265.4 6948.4 6981.7 7010.1 7024.3 5431.9 5436.8 5449.3 5453.3 5466.9 5251.8 5299.9 5422.7 5431.1 5434.6 13331.0 13371.7 13591.3 13850.7 13897.4 2157.6 2197.9 2254.0 2264.5 2383.7 10638.0 10702.3 10756.7 12781.0 13820.2 1982.2 2003.6 2007.2 2017.3 2053.4 65488.3 67321.3 67405.0 67441.0 67961.3 11382.5 11389.6 11459.3 11466.2 11571.9 14942.1 14973.9 15001.6 15099.8 15116.5 7977.0 8017.5 8030.9 8260.6 8263.8 7787.7 7995.6 8013.7 8043.7 8058.1 4481.9 4881.9 4903.7 4934.3 4972.5 1735.8 1898.6 1934.0 1950.8 1971.4 953.7 996.7 1015.6 1083.1 1114.9 14984.3 16633.8 17014.0 17298.0 17892.9 909.6 971.8 1015.8 1029.8 1033.6 9691.4 10137.9 10302.2 10439.5 10543.2 674894.0 678898.0 698515.0 700480.0 709309.0 87260.6 87787.0 89754.1 89903.1 90631.0 1210.8 1212.2 1215.3 1218.8 1223.4 16677.3 16710.2 16858.3 16902.4 16975.2 35975.6 36352.3 37126.6 37356.8 37782.4 48779.3 49190.0 49496.0 50623.7 51608.2 9923.6 10035.0 10178.0 10220.2 10263.9 12067.3 12162.6 14456.7 16539.4 16556.6 15181.8 15632.8 15965.1 15971.8 16172.3 15116.8 15597.2 15817.4 15872.5 16175.2 15566.8 16116.1 16145.8 16461.4 16793.7 10621.4 10640.6 10714.8 10726.4 10747.7 15077.3 15341.5 16036.8 16177.3 16339.3 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5560.37 Median:6764.54 stddev:2914.88 (43.1%) stddev-sans-first:2907.20 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: Values: 1514.5 1574.3 1619.3 1767.4 1907.4 7753.4 8168.6 8172.7 8182.7 8185.0 7766.9 7806.5 7808.8 7817.5 7820.7 2308.6 2321.5 2354.5 2355.7 2356.2 2171.8 2197.1 2198.2 2198.9 2199.2 2043.0 2090.5 2237.5 2290.8 2302.1 2144.9 2168.8 2191.6 2193.6 2196.7 2298.1 2327.7 2331.6 2332.7 2333.6 6870.8 7015.1 7512.5 7716.2 7716.5 4761.2 4875.4 4875.5 4875.9 4877.9 2975.1 3037.9 3053.1 3067.4 3072.1 1041.4 1049.2 1069.6 1081.1 1114.7 10563.9 10674.8 10679.5 10688.6 10689.9 4143.3 4161.8 4241.4 4245.5 4253.6 8845.0 8853.6 8862.9 8865.0 8884.9 4755.0 4768.1 4771.7 4771.8 4772.0 4427.6 4429.0 4429.4 4437.5 4448.0 3461.9 3497.8 3497.9 3523.2 3531.9 1024.8 1026.5 1032.3 1041.8 1043.0 1057.9 1081.6 1084.0 1286.4 1428.8 7511.5 7558.4 7613.0 7637.4 7823.3 514.3 515.9 520.1 524.0 533.0 5753.6 6176.8 6214.4 6223.3 6223.8 8769.3 9484.8 9493.0 9516.9 9517.2 9182.5 9329.0 9370.1 9392.0 9552.0 7497.3 7519.1 7577.1 7584.2 7599.2 7465.3 7608.0 7615.9 7640.9 7673.4 8249.1 8262.3 8298.0 8345.5 8619.7 8743.7 8788.0 8863.5 8900.7 9043.0 7195.3 7267.7 7272.0 7273.7 7274.8 7826.7 7913.3 7928.0 7940.9 7977.4 7392.0 7494.4 7497.2 7500.1 7522.1 7247.4 7257.1 7288.5 7307.5 7353.3 7330.8 7385.1 7451.3 7502.7 7503.8 6746.1 6783.0 6783.1 6783.9 6794.5 6815.5 6818.1 6876.1 6879.6 6887.2 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,889 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5409.45 Median:6141.80 stddev:1604.75 (26.1%) stddev-sans-first:1563.79 07:08:49 INFO - 2016-02-10 07:08:49,891 DEBUG : BROWSER_OUTPUT: Values: 356.2 360.9 365.6 367.0 368.4 5873.4 5937.5 6035.2 6036.9 6044.5 5869.2 6006.8 6010.8 6018.3 6025.3 4703.3 4717.3 4719.8 4720.8 4722.2 4540.0 4639.2 4647.3 4654.6 4725.7 4580.2 4682.7 4699.3 4706.3 4718.2 4678.0 4678.4 4679.8 4683.3 4683.6 4177.5 4181.8 4183.4 4187.3 4191.0 5614.4 5708.9 5712.0 5714.4 5720.0 5434.3 5449.9 5456.8 5462.3 5468.3 6109.0 6358.0 6358.8 6359.3 6364.0 4453.2 4470.8 4541.4 4544.9 4557.6 6557.7 6585.3 6590.8 6596.6 6598.5 4666.9 4674.6 4675.3 4675.7 4677.3 4656.7 4721.9 4724.1 4735.9 4737.8 5375.3 5387.5 5389.0 5389.5 5401.9 6410.0 6417.1 6423.3 6428.9 6428.9 1651.5 1708.6 1708.7 1709.7 1712.5 1111.6 1124.2 1125.7 1140.9 1154.0 6248.9 6249.9 6254.8 6256.9 6265.3 6610.1 6610.2 6617.2 6620.5 6621.7 6174.6 6255.7 6258.5 6273.9 6277.6 3558.9 3599.4 3599.6 3607.5 3609.9 6914.0 6915.9 6925.7 6926.1 6928.6 6695.0 6864.0 6872.8 6884.9 6887.6 6854.4 6906.2 6910.2 6912.8 6917.0 6430.8 6498.4 6563.9 6664.9 6665.6 6604.0 6606.6 6621.7 6631.0 6640.2 6869.9 6871.0 6881.6 6898.8 6918.6 4517.3 4600.8 4667.3 4689.1 4690.2 6646.8 6648.5 6650.8 6656.2 6658.5 6473.3 6478.6 6485.8 6488.6 6489.4 6274.7 6474.8 6488.1 6490.6 6491.5 6329.1 6341.3 6341.9 6343.2 6344.2 6542.5 6547.8 6553.4 6553.6 6565.4 6270.3 6379.6 6384.6 6385.9 6395.6 07:08:49 INFO - 2016-02-10 07:08:49,891 DEBUG : BROWSER_OUTPUT: 07:08:49 INFO - 2016-02-10 07:08:49,891 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14478.75 Median:4529.21 stddev:16618.99 (366.9%) stddev-sans-first:16634.00 07:08:49 INFO - 2016-02-10 07:08:49,891 DEBUG : BROWSER_OUTPUT: Values: 831.2 884.2 922.4 955.0 956.1 13721.7 13731.5 13754.8 13776.9 13796.9 13022.1 13036.9 13081.1 13134.3 13135.9 749.1 762.5 762.5 762.6 901.6 904.0 907.9 908.1 910.3 910.5 956.7 962.7 962.8 965.4 965.6 785.6 951.0 954.2 958.2 958.5 591.5 700.6 709.3 709.9 710.5 12830.1 12903.0 12922.2 12949.9 12949.9 12792.8 12833.2 13934.2 14006.2 14045.5 11474.3 11665.6 11704.4 11822.2 12022.3 3960.1 3980.8 3997.2 4035.9 4128.8 50385.0 50468.2 51244.0 51419.5 51684.5 10469.6 10625.1 10716.9 10801.6 10872.0 17957.0 17970.0 17977.1 17994.1 18051.9 7912.0 7956.3 7989.0 8030.9 8062.8 4421.0 4480.0 4578.5 4580.2 4585.8 3302.9 3314.2 3324.6 3339.3 3339.6 570.8 571.6 577.1 578.9 612.1 677.2 703.4 729.0 736.1 742.0 8857.6 9281.1 9300.8 9304.3 9327.4 513.5 612.1 699.4 773.2 793.0 4162.5 4443.5 4601.4 4708.9 4820.3 57117.1 57287.0 58351.7 59315.0 59714.7 52362.7 52674.5 52750.2 53115.0 55205.9 48271.5 48698.3 49286.0 51172.7 51614.7 8819.8 9178.8 9269.6 9373.2 9514.7 35977.3 37007.8 37250.0 37434.6 37681.0 44038.3 44538.0 47192.5 48271.5 49726.3 11741.5 11743.1 11944.2 12006.5 12059.9 11996.7 11999.7 12001.5 12079.5 12244.5 11578.8 11653.0 11763.5 11775.9 12057.3 12126.6 12194.9 12281.1 12370.0 12526.0 11493.7 11537.0 11851.3 11853.0 12271.6 10197.5 10761.0 11011.4 11054.6 11148.3 10202.9 10648.8 10686.0 10745.7 10784.1 07:08:49 INFO - 2016-02-10 07:08:49,891 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:08:49 INFO - 2016-02-10 07:08:49,891 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2016-02-10 07:08:50,481 INFO : Browser exited with error code: 0 07:08:50 INFO - 2016-02-10 07:08:50,502 INFO : Completed test dromaeo_css (00:18:30) 07:08:50 INFO - 2016-02-10 07:08:50,502 INFO : Starting test kraken 07:08:50 INFO - 2016-02-10 07:08:50,502 DEBUG : operating with platform_type : linux_ 07:08:50 INFO - 2016-02-10 07:08:50,502 INFO : Initialising browser for kraken test... 07:08:50 INFO - 2016-02-10 07:08:50,508 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp20YFHR/profile http://localhost:54545/getInfo.html 07:08:54 INFO - 2016-02-10 07:08:54,059 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:08:54 INFO - 2016-02-10 07:08:54,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:08:54 INFO - 2016-02-10 07:08:54,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:08:54 INFO - 2016-02-10 07:08:54,059 DEBUG : BROWSER_OUTPUT: __metrics 07:08:54 INFO - 2016-02-10 07:08:54,241 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] 07:08:55 INFO - 2016-02-10 07:08:55,209 INFO : Browser initialized. 07:08:55 INFO - 2016-02-10 07:08:55,210 INFO : Running cycle 1/1 for kraken test... 07:08:55 INFO - 2016-02-10 07:08:55,210 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp20YFHR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:09:06 INFO - 2016-02-10 07:09:06,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 132812800 07:09:06 INFO - 2016-02-10 07:09:06,864 DEBUG : BROWSER_OUTPUT: 07:09:09 INFO - 2016-02-10 07:09:09,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54545/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:09 INFO - 2016-02-10 07:09:09,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 165171200 07:09:09 INFO - 2016-02-10 07:09:09,862 DEBUG : BROWSER_OUTPUT: 07:09:12 INFO - 2016-02-10 07:09:12,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54545/tests/kraken/driver.html?testName=audio-dft) 07:09:12 INFO - 2016-02-10 07:09:12,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 164552704 07:09:12 INFO - 2016-02-10 07:09:12,996 DEBUG : BROWSER_OUTPUT: 07:09:15 INFO - 2016-02-10 07:09:15,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54545/tests/kraken/driver.html?testName=audio-fft) 07:09:16 INFO - 2016-02-10 07:09:16,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 160702464 07:09:16 INFO - 2016-02-10 07:09:16,325 DEBUG : BROWSER_OUTPUT: 07:09:18 INFO - 2016-02-10 07:09:18,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54545/tests/kraken/driver.html?testName=audio-oscillator) 07:09:18 INFO - 2016-02-10 07:09:18,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 160272384 07:09:18 INFO - 2016-02-10 07:09:18,824 DEBUG : BROWSER_OUTPUT: 07:09:20 INFO - 2016-02-10 07:09:20,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54545/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:21 INFO - 2016-02-10 07:09:21,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 159137792 07:09:21 INFO - 2016-02-10 07:09:21,550 DEBUG : BROWSER_OUTPUT: 07:09:24 INFO - 2016-02-10 07:09:24,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54545/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:24 INFO - 2016-02-10 07:09:24,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 158646272 07:09:24 INFO - 2016-02-10 07:09:24,956 DEBUG : BROWSER_OUTPUT: 07:09:28 INFO - 2016-02-10 07:09:28,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54545/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:28 INFO - 2016-02-10 07:09:28,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 158851072 07:09:28 INFO - 2016-02-10 07:09:28,798 DEBUG : BROWSER_OUTPUT: 07:09:31 INFO - 2016-02-10 07:09:31,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54545/tests/kraken/driver.html?testName=json-parse-financial) 07:09:32 INFO - 2016-02-10 07:09:32,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 158994432 07:09:32 INFO - 2016-02-10 07:09:32,035 DEBUG : BROWSER_OUTPUT: 07:09:33 INFO - 2016-02-10 07:09:33,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54545/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:34 INFO - 2016-02-10 07:09:34,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 163274752 07:09:34 INFO - 2016-02-10 07:09:34,144 DEBUG : BROWSER_OUTPUT: 07:09:35 INFO - 2016-02-10 07:09:35,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:09:36 INFO - 2016-02-10 07:09:36,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 163127296 07:09:36 INFO - 2016-02-10 07:09:36,480 DEBUG : BROWSER_OUTPUT: 07:09:38 INFO - 2016-02-10 07:09:38,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:09:38 INFO - 2016-02-10 07:09:38,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 169889792 07:09:38 INFO - 2016-02-10 07:09:38,998 DEBUG : BROWSER_OUTPUT: 07:09:41 INFO - 2016-02-10 07:09:41,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:41 INFO - 2016-02-10 07:09:41,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 172711936 07:09:41 INFO - 2016-02-10 07:09:41,946 DEBUG : BROWSER_OUTPUT: 07:09:44 INFO - 2016-02-10 07:09:44,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:09:44 INFO - 2016-02-10 07:09:44,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 171540480 07:09:44 INFO - 2016-02-10 07:09:44,998 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54545/tests/kraken/driver.html?testName=ai-astar) 07:09:46 INFO - 2016-02-10 07:09:46,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 229023744 07:09:46 INFO - 2016-02-10 07:09:46,897 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,899 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:09:46 INFO - 2016-02-10 07:09:46,899 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:09:46 INFO - 2016-02-10 07:09:46,899 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:09:46 INFO - 2016-02-10 07:09:46,899 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:09:46 INFO - 2016-02-10 07:09:46,899 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;107;108;108;99;109;108;112 07:09:46 INFO - 2016-02-10 07:09:46,899 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;121;144;164;122;148;143;131;164;127 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;159;159;158;160;160;161;160;160 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;72;146;71;71;71;72;147;70 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;136;91;93;92;140;92;92;135 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;109;109;109;109;109;109;109;109;109 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;145;146;145;145;145;145;145;145 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;57;56;55;55;57;55;54;53 07:09:46 INFO - 2016-02-10 07:09:46,900 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;64;65;64;64;65;64;64 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;79;77;79;78;78;77;78;77;77 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;125;118;122;112;113;113;112;127;126 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;141;140;141;142;134;140;149;140;130 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;64;68;65;63;63;63;62;62;62 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:09:46 INFO - 2016-02-10 07:09:46,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,871 07:09:46 INFO - 2016-02-10 07:09:46,902 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:09:46 INFO - 2016-02-10 07:09:46,902 DEBUG : BROWSER_OUTPUT: __startTimestamp1455116986898__endTimestamp 07:09:46 INFO - 2016-02-10 07:09:46,902 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,909 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:09:46 INFO - 2016-02-10 07:09:46,909 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:108.50 stddev:3.49 (3.2%) stddev-sans-first:3.69 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 107.0 108.0 108.0 99.0 109.0 108.0 112.0 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.40 Median:146.00 stddev:15.83 (10.8%) stddev-sans-first:16.49 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: Values: 150.0 121.0 144.0 164.0 122.0 148.0 143.0 131.0 164.0 127.0 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 159.0 159.0 158.0 160.0 160.0 161.0 160.0 160.0 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.40 Median:71.00 stddev:31.69 (44.6%) stddev-sans-first:33.24 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 72.0 146.0 71.0 71.0 71.0 72.0 147.0 70.0 07:09:46 INFO - 2016-02-10 07:09:46,910 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:21.71 (23.6%) stddev-sans-first:22.54 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 136.0 91.0 93.0 92.0 140.0 92.0 92.0 135.0 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 07:09:46 INFO - 2016-02-10 07:09:46,911 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.32 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 57.0 56.0 55.0 55.0 57.0 55.0 54.0 53.0 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: Values: 77.0 79.0 77.0 79.0 78.0 78.0 77.0 78.0 77.0 77.0 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.00 stddev:6.15 (5.1%) stddev-sans-first:6.40 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: Values: 115.0 125.0 118.0 122.0 112.0 113.0 113.0 112.0 127.0 126.0 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,912 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:141.00 stddev:5.02 (3.6%) stddev-sans-first:5.27 07:09:46 INFO - 2016-02-10 07:09:46,913 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 140.0 141.0 142.0 134.0 140.0 149.0 140.0 130.0 07:09:46 INFO - 2016-02-10 07:09:46,913 DEBUG : BROWSER_OUTPUT: 07:09:46 INFO - 2016-02-10 07:09:46,913 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:2.13 (3.4%) stddev-sans-first:1.94 07:09:46 INFO - 2016-02-10 07:09:46,913 DEBUG : BROWSER_OUTPUT: Values: 67.0 64.0 68.0 65.0 63.0 63.0 63.0 62.0 62.0 62.0 07:09:46 INFO - 2016-02-10 07:09:46,913 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:09:46 INFO - 2016-02-10 07:09:46,913 DEBUG : BROWSER_OUTPUT: 07:09:47 INFO - 2016-02-10 07:09:47,573 INFO : Browser exited with error code: 0 07:09:47 INFO - 2016-02-10 07:09:47,629 INFO : Completed test kraken (00:00:57) 07:09:47 INFO - 2016-02-10 07:09:47,629 INFO : Starting test v8_7 07:09:47 INFO - 2016-02-10 07:09:47,630 DEBUG : operating with platform_type : linux_ 07:09:47 INFO - 2016-02-10 07:09:47,630 INFO : Initialising browser for v8_7 test... 07:09:47 INFO - 2016-02-10 07:09:47,636 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv5a20V/profile http://localhost:54545/getInfo.html 07:09:51 INFO - 2016-02-10 07:09:51,120 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:09:51 INFO - 2016-02-10 07:09:51,120 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:09:51 INFO - 2016-02-10 07:09:51,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:09:51 INFO - 2016-02-10 07:09:51,121 DEBUG : BROWSER_OUTPUT: __metrics 07:09:51 INFO - 2016-02-10 07:09:51,263 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] 07:09:52 INFO - 2016-02-10 07:09:52,377 INFO : Browser initialized. 07:09:52 INFO - 2016-02-10 07:09:52,378 INFO : Running cycle 1/1 for v8_7 test... 07:09:52 INFO - 2016-02-10 07:09:52,378 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv5a20V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:10:04 INFO - 2016-02-10 07:10:04,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 133947392 07:10:04 INFO - 2016-02-10 07:10:04,062 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54545/tests/v8_7/run.html (next: http://localhost:54545/tests/v8_7/run.html) 07:10:25 INFO - 2016-02-10 07:10:25,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 419889152 07:10:25 INFO - 2016-02-10 07:10:25,647 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,647 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:10:25 INFO - 2016-02-10 07:10:25,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:10:25 INFO - 2016-02-10 07:10:25,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:10:25 INFO - 2016-02-10 07:10:25,647 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |0;Richards;166.08536787908986 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.66326362588507 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |4;RayTrace;966.1835748792271 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |5;Earley;540.2485143165857 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 07:10:25 INFO - 2016-02-10 07:10:25,648 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: |8;Splay;525.7623554153523 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: __startTimestamp1455117025640__endTimestamp 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:10:25 INFO - 2016-02-10 07:10:25,649 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: Values: 166.1 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.66 Median:164.66 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: Values: 164.7 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,650 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: Values: 279.3 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: Values: 5202.1 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:966.18 Median:966.18 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,651 DEBUG : BROWSER_OUTPUT: Values: 966.2 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.25 Median:540.25 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: Values: 540.2 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: Values: 10526.3 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,652 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: Values: 26256.4 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.76 Median:525.76 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: Values: 525.8 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:10:25 INFO - 2016-02-10 07:10:25,653 DEBUG : BROWSER_OUTPUT: Values: 4822.1 07:10:25 INFO - 2016-02-10 07:10:25,654 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:10:25 INFO - 2016-02-10 07:10:25,654 DEBUG : BROWSER_OUTPUT: 07:10:26 INFO - 2016-02-10 07:10:26,378 INFO : Browser exited with error code: 0 07:10:26 INFO - 2016-02-10 07:10:26,392 INFO : Completed test v8_7 (00:00:38) 07:10:26 INFO - 2016-02-10 07:10:26,742 INFO : Completed test suite (00:20:06) 07:10:26 INFO - 2016-02-10 07:10:26,742 DEBUG : Working with test: dromaeo_css 07:10:26 INFO - 2016-02-10 07:10:26,742 DEBUG : Generating results file: dromaeo_css 07:10:26 INFO - 2016-02-10 07:10:26,744 DEBUG : Working with test: kraken 07:10:26 INFO - 2016-02-10 07:10:26,744 DEBUG : Generating results file: kraken 07:10:26 INFO - 2016-02-10 07:10:26,744 INFO : javascript benchmark 07:10:26 INFO - 2016-02-10 07:10:26,744 DEBUG : Working with test: v8_7 07:10:26 INFO - 2016-02-10 07:10:26,745 DEBUG : Generating results file: v8_7 07:10:26 INFO - 2016-02-10 07:10:26,745 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:26 INFO - 2016-02-10 07:10:26,807 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 07:10:26 INFO - 2016-02-10 07:10:26,807 DEBUG : process_Request line: dromaeo_css 7389.77 graph.html#tests=[[72,53,35]] 07:10:26 INFO - 2016-02-10 07:10:26,808 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:26 INFO - 2016-02-10 07:10:26,851 DEBUG : process_Request line: kraken 1468.70 graph.html#tests=[[232,53,35]] 07:10:26 INFO - 2016-02-10 07:10:26,851 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:10:26 INFO - 2016-02-10 07:10:26,892 DEBUG : process_Request line: v8_7 23080.67 graph.html#tests=[[230,53,35]] 07:10:26 INFO - 2016-02-10 07:10:26,894 INFO : javascript benchmark 07:10:26 INFO - 2016-02-10 07:10:26,897 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3261.1847038240435, 3328.7170590499804, 3354.1614596350914, 3354.966450335496, 3372.2412457197124, 5428.158635411518, 5460.372057213422, 5467.261919640848, 5470.179473079035, 5491.670499770016, 5484.533814625752, 5487.094629386146, 5493.642913210639, 5502.58730595206, 5508.807191748289, 4961.776720047606, 5024.899502009957, 5054.1660625996665, 5054.772535235923, 5083.415407228179, 4938.16051271283, 4979.975100124494, 4990.925136122961, 5054.064997975368, 5060.7722652480725, 5063.924041139386, 5101.84694459165, 5115.0, 5118.6416950813455, 5140.228965655144, 5023.748812559394, 5028.7737051832755, 5097.719625420582, 5111.284420181178, 5113.130767769489, 4868.342773725537, 4934.8766280843265, 4963.975180124113, 5041.420236672793, 5048.7728052237735, 5280.52475277223, 5286.392064912546, 5296.92054619181, 5318.760655770499, 5344.893102137974, 5682.6306290091425, 5924.140999555084, 5926.2295901532525, 5927.792527261525, 5971.313298970587, 5869.295684517842, 5921.763129474859, 6033.577649564532, 6053.878922421527, 6064.363241859585, 5525.751341189656, 5530.806421775219, 5536.584756143265, 5539.335279766454, 5550.666959982414, 5852.648841069549, 6018.097285407224, 6020.8259389418645, 6028.487578555872, 6030.4572588467245, 5744.109663002241, 5823.242978412779, 5904.940950590525, 5921.940780592139, 5939.930812453714, 5995.790147344909, 5997.160397544348, 6000.609960352563, 6004.669743164168, 6008.549358798107, 5907.1434641976675, 5922.585419020714, 5932.703364831741, 5939.049752039653, 5942.227510423617, 5677.261955945701, 5771.192033115367, 5798.449147330997, 5864.266966629171, 5865.941340586625, 4470.709403888737, 4489.865304040884, 4494.9325760113625, 4498.032922921588, 4519.412476378116, 3974.5826688197903, 4041.211963667057, 4045.130296986162, 4065.4105154752397, 4075.1645912587846, 5477.4796394342475, 5572.414896435897, 5593.133064375028, 5626.97186514073, 5645.23789288449, 5904.114382842522, 5955.196048533479, 5963.224780778558, 5965.164876917235, 5969.940300597025, 5511.559075273968, 5604.579656525777, 5668.0, 5680.375158732536, 5692.203091567184, 4964.652474326835, 5024.271480635361, 5037.0, 5038.017586570583, 5061.367329083864, 6038.215032045806, 6085.36103709113, 6093.26880774301, 6095.420935011167, 6099.2680878294, 5671.688057156896, 5712.742926568398, 5739.5695322850115, 5902.291724992857, 5934.910976335272, 6085.604435711664, 6121.571489995836, 6130.63216207029, 6130.785422510191, 6135.662538560422, 5844.853878653068, 5889.087191485327, 5891.469767720754, 5903.350631430625, 5914.733836977261, 5688.77244910199, 5789.102689083199, 5860.560457965585, 5930.406959304035, 5979.431953964367, 5782.855428614318, 5809.331926828469, 5813.82558523245, 5814.854628634318, 5816.360200377871, 5817.981853175762, 5823.126531020212, 5823.767049317979, 5827.329857066322, 5829.8251052468495, 5482.725863706878, 5499.395066542597, 5569.248151499496, 5613.775448981995, 5613.90528846871, 5797.391273916178, 5798.6810725410505, 5801.506871915934, 5802.796902108406, 5820.214271073351, 5529.281193444987, 5627.268455100811, 5628.971855140698, 5666.17840413146, 5672.801451949162], "unit": "ms", "name": "dojo.html", "value": 5441.400695391967}, {"lowerIsBetter": false, "replicates": [579.6319337220866, 624.6314674342138, 630.1209812311822, 633.2812258087071, 700.3766647683559, 33960.32079358414, 42985.78507107464, 43047.35428968568, 43354.0, 43360.56639433613, 47392.28911566329, 47713.522864771345, 47777.7611111944, 48075.51924480754, 48091.03817923639, 8066.11272759996, 8178.5092894426525, 9253.999999999984, 9437.056294370577, 9447.952760236223, 11028.062614677761, 11254.0, 11298.0, 11318.20772545922, 11330.830037549444, 11037.172212084086, 11177.608783692573, 11179.4969226385, 11179.944100279487, 11189.048930840889, 11069.667909962714, 11086.16853735965, 11137.777244455106, 11166.888331116666, 11172.608958686447, 10906.945465272702, 11031.944840275828, 11048.889511104866, 11049.17131215154, 11066.612668556561, 45131.32303015458, 45352.3197152043, 45409.0, 45456.318155227695, 45512.77243613761, 3478.0783092480515, 3480.3909315869623, 3491.8476902622074, 3494.982525087358, 3568.678818906285, 33840.49239261413, 34243.6575634243, 34300.82849585761, 34427.4835877462, 34452.65547344519, 4295.398644189816, 4430.136123455927, 4467.620252278561, 4490.797914093873, 4514.255147900592, 303682.0, 305171.0, 305740.0, 305909.0, 307283.0, 60619.696901516094, 68563.65718171476, 69040.0, 69092.999999999, 69144.30855691379, 60180.699096505115, 60344.39655603388, 78254.21745782583, 82069.58965205136, 82142.0, 17598.0, 17613.823861761473, 17789.377371791925, 17791.19939602695, 17859.196336164903, 13736.65658358549, 13836.031477796458, 13875.444982200599, 13885.583432497042, 13887.097338672955, 22436.66345004826, 22557.774422255894, 22841.428964275692, 22855.771442285695, 22909.88545057264, 8105.675772969015, 8227.794305142419, 8338.374621903382, 8373.95813020931, 8442.957785211034, 1069.1820757120809, 1075.0432115417284, 1084.8318510630866, 1113.4989254835357, 1231.132051903406, 28730.425391492052, 29505.852470737507, 29973.0, 30732.53901191484, 31181.064568062993, 972.8686627305365, 1118.278710231912, 1123.601121601836, 1151.5911851292838, 1176.9411529423494, 14109.71780564383, 14785.556433306803, 14866.851331486763, 16201.108939008232, 16468.142459975923, 369879.0, 374630.0, 374705.0, 375549.0, 375890.0, 60803.39196607978, 60938.69530652319, 60962.0, 60983.39016609866, 61065.694671526355, 1257.6918654929418, 1280.2830414967648, 1372.979405308921, 1374.5944946240884, 1377.318227477385, 28010.2997425066, 28067.298317542223, 28719.138425847257, 28872.278193045342, 29663.85168074146, 47487.52512474969, 47829.76085119552, 47891.0, 53836.0, 54515.45484545104, 454463.0, 458148.0, 461234.0, 463904.0, 464443.0, 35508.82245588755, 35594.46608300826, 36181.27637447184, 36192.457113142795, 36218.0, 48359.0, 49005.0, 49097.526775858125, 49413.0, 49536.0, 39700.0, 40310.596894031856, 40330.395044073775, 40996.590034099274, 41839.0, 41249.76901447885, 41386.58613413948, 41786.0, 42035.36946945737, 47160.52839471561, 40817.387739183345, 43002.35496467618, 43440.34839477347, 44218.557814421445, 44288.0, 42619.360709588764, 44479.332810007225, 44703.05496138236, 44728.0, 45399.09201815879, 33561.66438335683, 36114.54676029268, 36745.63254367422, 36880.44679329758, 37186.6281337194], "unit": "ms", "name": "ext.html", "value": 21327.43737405649}, {"lowerIsBetter": false, "replicates": [389.12835249042143, 389.2623478508227, 389.4392075411407, 389.82652719539817, 395.3200495148344, 14665.193414362206, 17225.655486890286, 17382.478525644234, 19951.201951921925, 19957.201711931524, 19266.807331926677, 19277.0, 19282.807171928278, 19518.21927122917, 19544.31594894179, 6195.566310358288, 6289.842753931142, 6327.209098862642, 6354.904676429857, 6357.205349331333, 4609.953900461002, 4747.881302967437, 6313.053042043684, 6827.112475378194, 7046.154461464605, 5265.368155821307, 6948.444124470056, 6981.720731170747, 7010.053642758214, 7024.332688394595, 5431.918521222185, 5436.836894893159, 5449.346078470569, 5453.345598528163, 5466.863328416802, 5251.842444726664, 5299.894002119974, 5422.674639521641, 5431.131019036975, 5434.592405569598, 13331.0, 13371.665708357368, 13591.320433978262, 13850.653733656638, 13897.374618142208, 2157.56848630273, 2197.8681279123302, 2253.9774602253933, 2264.4904896398343, 2383.6662867198606, 10638.042576168105, 10702.304350217211, 10756.731081723019, 12780.977521798233, 13820.170789752647, 1982.1674896543486, 2003.5892642008353, 2007.1670256843393, 2017.3040301096098, 2053.3839848045677, 65488.3451165487, 67321.326786732, 67405.0, 67441.0, 67961.320386796, 11382.487788049557, 11389.601363952223, 11459.31244125355, 11466.197366184288, 11571.942140289244, 14942.103473791607, 14973.925130374279, 15001.624959375884, 15099.849001510063, 15116.54650360491, 7976.960115199387, 8017.478863873829, 8030.9196908031345, 8260.628271727786, 8263.834723305501, 7787.688492460238, 7995.560244186509, 8013.719519816778, 8043.6782528698195, 8058.11360750317, 4481.910361792811, 4881.926771098365, 4903.681260718042, 4934.309196712463, 4972.5276098770555, 1735.8298641851968, 1898.5633304340079, 1934.023318224316, 1950.8439324853978, 1971.3888694504749, 953.6709835106877, 996.6960077176386, 1015.6343716262139, 1083.1443159903745, 1114.905233055183, 14984.325705343286, 16633.83366166323, 17014.0, 17298.0, 17892.910535447238, 909.5906841921162, 971.834788086013, 1015.7511409704522, 1029.7683021320142, 1033.5865653738565, 9691.370060946016, 10137.93551677078, 10302.227332950059, 10439.530221140067, 10543.209259305582, 674894.0, 678898.0, 698515.0, 700480.0, 709309.0, 87260.56369718238, 87787.0, 89754.10245897458, 89903.10096899078, 90631.0, 1210.842590463234, 1212.2423485321497, 1215.3437143942172, 1218.7867123253395, 1223.443333283354, 16677.33290668408, 16710.164491775606, 16858.325666973673, 16902.40841570539, 16975.236114374635, 35975.64024359723, 36352.27295454129, 37126.6287337134, 37356.81321593375, 37782.43326350052, 48779.26831097608, 49190.0, 49496.0, 50623.74688126536, 51608.22587661263, 9923.603055877684, 10035.0, 10178.0, 10220.182385409298, 10263.948680256552, 12067.275963442222, 12162.574309899112, 14456.710865782416, 16539.421120260733, 16556.586085347964, 15181.772273416129, 15632.843671563594, 15965.121918294606, 15971.760423593423, 16172.272247748644, 15116.848831511545, 15597.220138992778, 15817.367305307658, 15872.52382428529, 16175.191240438166, 15566.844331556993, 16116.113613751357, 16145.838541614903, 16461.423850165185, 16793.74809377836, 10621.415822129857, 10640.627578034731, 10714.785704285714, 10726.410047447465, 10747.677569672922, 15077.321520531383, 15341.539753807403, 16036.839631603534, 16177.27202275924, 16339.264733087277], "unit": "ms", "name": "jquery.html", "value": 9558.696160925414}, {"lowerIsBetter": false, "replicates": [1514.5077849698848, 1574.2679653960909, 1619.2632352279713, 1767.3725827331298, 1907.3896353166992, 7753.379729621631, 8168.63241154148, 8172.673093076285, 8182.713605023825, 8184.959075204616, 7766.922330776691, 7806.531608103518, 7808.8047798805055, 7817.491863028899, 7820.726274580391, 2308.6421604651305, 2321.466062805556, 2354.458474550854, 2355.705536807899, 2356.2460012795914, 2171.7936796004356, 2197.0662468450923, 2198.1537108213292, 2198.890055497219, 2199.2082850174006, 2043.039771307483, 2090.5296308330658, 2237.4741935645193, 2290.770922907704, 2302.0561569756405, 2144.8927553622334, 2168.8373371997163, 2191.6274233380364, 2193.583219188357, 2196.736391632998, 2298.069281940817, 2327.650852372141, 2331.63859601762, 2332.650102484624, 2333.5916214662534, 6870.7595234166565, 7015.088038554955, 7512.474126811126, 7716.189800071024, 7716.459847810655, 4761.2143996240575, 4875.390576177978, 4875.53682400175, 4875.902481950341, 4877.878053048702, 2975.1074677596635, 3037.9088627340993, 3053.0993356959752, 3067.4171907337536, 3072.078376487067, 1041.427215031737, 1049.1659130990881, 1069.6149386220955, 1081.0594782539242, 1114.6656003199007, 10563.94718026405, 10674.839877401846, 10679.519421626046, 10688.572457101707, 10689.946550267277, 4143.295639741251, 4161.75029498225, 4241.406203131564, 4245.469316335458, 4253.595908388698, 8845.0, 8853.601587928559, 8862.936447626198, 8865.0, 8884.8667269991, 4755.0489902019735, 4768.1417344878255, 4771.73755443447, 4771.785269662873, 4772.0217355442055, 4427.579379958899, 4429.047754732684, 4429.379886815848, 4437.511873693891, 4448.0, 3461.9480707789403, 3497.842597083137, 3497.89506314811, 3523.1544429336773, 3531.8940431787087, 1024.8206563851297, 1026.4867566216892, 1032.2928793776287, 1041.8228901086834, 1042.9843552346722, 1057.9259451838298, 1081.6106201767357, 1084.0, 1286.395394164741, 1428.7713965765636, 7511.51175173612, 7558.395328373717, 7612.961935190288, 7637.389008879276, 7823.335016523545, 514.3467795899262, 515.8658748725359, 520.0560981818064, 523.9895202095937, 533.0298856081894, 5753.568482363839, 6176.7838125666285, 6214.378562143749, 6223.253209614875, 6223.751049957951, 8769.298456123495, 9484.810303793885, 9492.95253523728, 9516.857247141299, 9517.23862091031, 9182.540872956459, 9328.95335523318, 9370.10983956523, 9391.953040234755, 9552.044795520393, 7497.250274972568, 7519.097708275042, 7577.0907491101425, 7584.241575842482, 7599.202083781234, 7465.328120469184, 7608.0489938757655, 7615.923840761521, 7640.885386719093, 7673.386129109769, 8249.092599814136, 8262.256396924306, 8297.95851020741, 8345.54099524532, 8619.655213791379, 8743.650253989768, 8788.033316335326, 8863.468191908507, 8900.73297801067, 9042.954785226031, 7195.280471952763, 7267.672954717156, 7272.0, 7273.745418910313, 7274.781756547312, 7826.686932522863, 7913.287804097428, 7927.960360198393, 7940.920590794018, 7977.401694872791, 7391.963040184764, 7494.3629791466155, 7497.175310715707, 7500.062492188476, 7522.097348318237, 7247.383972362198, 7257.092863392076, 7288.489805713549, 7307.525010874276, 7353.264673532604, 7330.816729581803, 7385.076865391826, 7451.254874512722, 7502.737404190827, 7503.812404689708, 6746.089277947414, 6783.0, 6783.084283621845, 6783.89824152648, 6794.4904132189295, 6815.488838337045, 6818.113645226089, 6876.071730316343, 6879.621620810904, 6887.2079710831895], "unit": "ms", "name": "mootools.html", "value": 4466.440835193989}, {"lowerIsBetter": false, "replicates": [356.2092155414981, 360.85926488669406, 365.64532403568535, 367.03835949811497, 368.4399712437094, 5873.353931067579, 5937.495312898403, 6035.215421995134, 6036.939630603692, 6044.486218671407, 5869.2369991901, 6006.819795406134, 6010.789622363218, 6018.307894592123, 6025.276966763994, 4703.270992996074, 4717.339572459859, 4719.764011799413, 4720.763961801913, 4722.244440889458, 4539.9773001134945, 4639.211334073216, 4647.349371088034, 4654.581087702106, 4725.740084295362, 4580.1984652685815, 4682.6956247843955, 4699.318598803172, 4706.317583950326, 4718.174319494092, 4677.976610116962, 4678.438587369537, 4679.836205732783, 4683.274092515666, 4683.601893839028, 4177.498700156001, 4181.790910454465, 4183.393407955829, 4187.330027195634, 4190.979045104786, 5614.382417934024, 5708.914366284509, 5711.971440142815, 5714.399988001242, 5720.0, 5434.347878254595, 5449.945500544984, 5456.83629491112, 5462.262594549725, 5468.26178465906, 6108.969455152695, 6358.0462930560325, 6358.7774427895265, 6359.332270111664, 6363.968180159116, 4453.198424283628, 4470.75410852403, 4541.386912766768, 4544.8863778405475, 4557.58981691646, 6557.672116394161, 6585.308542603006, 6590.802275931682, 6596.571222870546, 6598.47212223021, 4666.929996050062, 4674.6026587740425, 4675.322078298627, 4675.742834144155, 4677.251639737626, 4656.720596764205, 4721.858344249678, 4724.078804633064, 4735.857924262209, 4737.763111844394, 5375.274337964403, 5387.46125387466, 5388.9730551347775, 5389.51494365509, 5401.945980540223, 6410.0, 6417.069524918954, 6423.261324947691, 6428.935710642833, 6428.935710642927, 1651.4550198434488, 1708.6070203853183, 1708.7436884467181, 1709.726443768991, 1712.5119340987758, 1111.6109361723331, 1124.1512657943201, 1125.662301309604, 1140.9201355905172, 1154.0133186125909, 6248.875022499525, 6249.875002499924, 6254.781082662085, 6256.906146407808, 6265.279492858289, 6610.0745895574655, 6610.206775187008, 6617.172853393326, 6620.470362370998, 6621.702023408958, 6174.629522228681, 6255.749770009149, 6258.499320054476, 6273.937260627426, 6277.5605707600025, 3558.893233203008, 3599.406097993854, 3599.640035996432, 3607.4769158471877, 3609.855605775792, 6913.965430172918, 6915.930840691629, 6925.722971081201, 6926.099607051152, 6928.61892595902, 6694.9665251674405, 6863.965680171667, 6872.759453419107, 6884.931150688529, 6887.586744795329, 6854.417374523122, 6906.240313565504, 6910.239873613898, 6912.827179320457, 6916.965415172892, 6430.7749228776765, 6498.415142636996, 6563.9343606565235, 6664.900026499703, 6665.600063996176, 6603.966980165068, 6606.636634985122, 6621.735130594915, 6631.0, 6640.203175618956, 6869.900815869437, 6870.96935459685, 6881.621510816954, 6898.827529311607, 6918.584884906922, 4517.277235642281, 4600.849787553112, 4667.346571479928, 4689.132510485571, 4690.202665546797, 6646.767363142267, 6648.501362397743, 6650.83372915681, 6656.167979002625, 6658.500612453989, 6473.320301368477, 6478.578892371981, 6485.837854053498, 6488.610683359014, 6489.415952564292, 6274.717637706223, 6474.773382931575, 6488.059231411325, 6490.578112422678, 6491.4806815455595, 6329.1139240505445, 6341.270753863365, 6341.8731625368155, 6343.207099112611, 6344.175257216532, 6542.476601871934, 6547.803565893031, 6553.442957348679, 6553.574017689026, 6565.42429816831, 6270.278917924315, 6379.553431259953, 6384.648844313421, 6385.87228255423, 6395.552311338348], "unit": "ms", "name": "prototype.html", "value": 4897.816045532561}, {"lowerIsBetter": false, "replicates": [831.1771346367094, 884.204216205415, 922.4419226368047, 954.9761255968602, 956.1346980982214, 13721.656958576028, 13731.519396821113, 13754.793678094837, 13776.931115344421, 13796.931015344935, 13022.088453808237, 13036.934815325934, 13081.149725267875, 13134.277614731185, 13135.93432032841, 749.108560812634, 762.5119923249125, 762.523422860712, 762.5767698927093, 901.5852707754408, 904.0462312260562, 907.9092090790934, 908.0919080919081, 910.3309067835169, 910.517425764346, 956.7082039977804, 962.7304354780673, 962.7929995051063, 965.420747551467, 965.6378857928277, 785.6346798738614, 950.9714708558754, 954.2127744610689, 958.2094771813212, 958.4536814016013, 591.4676790888235, 700.6426722371627, 709.3048812164056, 709.9148102227714, 710.4777988178685, 12830.101892867502, 12903.0, 12922.224666520038, 12949.870501294961, 12949.870501294961, 12792.808107878389, 12833.230006199658, 13934.233617151052, 14006.22965736884, 14045.508407205802, 11474.311541307548, 11665.591704290395, 11704.356260405675, 11822.231554948987, 12022.338771367571, 3960.148568057881, 3980.7810570418615, 3997.1805779815068, 4035.8587449439424, 4128.8348466061325, 50385.0, 50468.24297635538, 51244.0, 51419.48580514184, 51684.483155168346, 10469.633562825416, 10625.149988000941, 10716.93086187775, 10801.567937282422, 10872.0, 17957.0, 17970.0, 17977.1011449427, 17994.100294985197, 18051.909740451214, 7912.0, 7956.283934445928, 7989.0, 8030.879536806952, 8062.838743225103, 4420.955790442119, 4479.977600111979, 4578.450585929643, 4580.198465268565, 4585.79363928624, 3302.9174270642948, 3314.2211580278617, 3324.5511855899144, 3339.3488269787645, 3339.5992480902446, 570.8316046766214, 571.5598988778618, 577.1112486770411, 578.9363170051291, 612.0788213738384, 677.1941389746187, 703.391566295151, 729.0437276842349, 736.1056316575387, 742.0, 8857.557122143868, 9281.118293762082, 9300.813983720287, 9304.348695591243, 9327.393719408217, 513.5352505982092, 612.0757655939564, 699.3985172751429, 773.1997382708869, 792.9960350198328, 4162.458880345535, 4443.466783985942, 4601.372426699938, 4708.858734237979, 4820.30105634681, 57117.14324285139, 57287.0, 58351.70824145937, 59315.0, 59714.70142649259, 52362.73818630882, 52674.47325526696, 52750.208746868826, 53115.0, 55205.895882082135, 48271.5172848267, 48698.26952595714, 49286.0, 51172.74413627983, 51614.74192629013, 8819.823603527766, 9178.770530736785, 9269.582868771056, 9373.1564159226, 9514.666986655433, 35977.28045439024, 37007.814960925025, 37250.0, 37434.62565374311, 37681.0, 44038.33942490801, 44538.0, 47192.528074718815, 48271.5172848267, 49726.25410618916, 11741.47163377633, 11743.119266055252, 11944.223625464318, 12006.459709312927, 12059.939700301442, 11996.700082498008, 11999.680753421742, 12001.459934302802, 12079.51681932748, 12244.510219591117, 11578.76842463163, 11653.0, 11763.529458821551, 11775.941120294343, 12057.276563406223, 12126.575569855013, 12194.939025304817, 12281.078919080926, 12370.0, 12526.0, 11493.655190343969, 11537.01935335506, 11851.348175850411, 11853.0, 12271.57049503263, 10197.490125493547, 10761.031507164393, 11011.433071179974, 11054.613088541862, 11148.275362101438, 10202.948985255027, 10648.84026739584, 10686.0, 10745.677629671123, 10784.137269018616], "unit": "ms", "name": "yui.html", "value": 6710.095228515214}], "name": "dromaeo_css", "value": 7389.766765434537}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 104.0, 107.0, 108.0, 108.0, 99.0, 109.0, 108.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [150.0, 121.0, 144.0, 164.0, 122.0, 148.0, 143.0, 131.0, 164.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 159.0, 158.0, 160.0, 160.0, 161.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 159.8}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 146.0, 71.0, 71.0, 71.0, 72.0, 147.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 136.0, 91.0, 93.0, 92.0, 140.0, 92.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 56.0, 55.0, 55.0, 57.0, 55.0, 54.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 77.0, 79.0, 78.0, 78.0, 77.0, 78.0, 77.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.7}, {"lowerIsBetter": true, "replicates": [115.0, 125.0, 118.0, 122.0, 112.0, 113.0, 113.0, 112.0, 127.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 140.0, 141.0, 142.0, 134.0, 140.0, 149.0, 140.0, 130.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 68.0, 65.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1468.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [164.66326362588507], "unit": "score", "name": "DeltaBlue", "value": 401.5346139999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [966.1835748792271], "unit": "score", "name": "RayTrace", "value": 765.8886149999998}, {"lowerIsBetter": false, "replicates": [540.2485143165857], "unit": "score", "name": "Earley", "value": 1233.6230130000004}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [525.7623554153523], "unit": "score", "name": "Splay", "value": 154.995882}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23080.666852850914}]} 07:10:26 INFO - RETURN: dromaeo_css: 7389.77 07:10:26 INFO - RETURN: kraken: 1468.70 07:10:26 INFO - RETURN: v8_7: 23080.67 07:10:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23080.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1468.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7389.77"}}} 07:10:26 INFO - Return code: 0 07:10:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:10:27 INFO - # TBPL SUCCESS # 07:10:27 INFO - Running post-action listener: _resource_record_post_action 07:10:27 INFO - Running post-run listener: _resource_record_post_run 07:10:28 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 516329472; Read time: 292; Write time: 642336 07:10:28 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 4096; Write bytes: 253161472; Read time: 108; Write time: 430668 07:10:28 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 262950912; Read time: 184; Write time: 211644 07:10:28 INFO - Running post-run listener: _upload_blobber_files 07:10:28 INFO - Blob upload gear active. 07:10:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:10:28 INFO - Copying logs to upload dir... 07:10:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.999524 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-10 07:10:27.831260) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-10 07:10:27.834916) ========= 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010044 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455107240/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-10 07:10:27.886721) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 07:10:27.887067) ========= 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=a0d2d2de893abaa8702a9954000001a7-1455115240.500282-768885864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 07:10:27.938436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 07:10:27.939055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 07:10:27.939642) ========= ========= Total master_lag: 0.45 =========