builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1456581185.3 results: success (0) buildid: 20160227030205 builduid: 76621c0ab39b4892aa621e6e6e034181 revision: 5e0140b6d11821e0c2a2de25bc5431783f03380a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.301734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.302740) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.303465) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005216 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.325249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.325552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.337992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.338478) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004730 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.391043) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.391727) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.392504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.393219) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 05:53:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-02-27 05:53:06 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.587138) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.587482) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018625 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.641169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:05.642032) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e0140b6d11821e0c2a2de25bc5431783f03380a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5e0140b6d11821e0c2a2de25bc5431783f03380a --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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 05:53:06,219 truncating revision to first 12 chars 2016-02-27 05:53:06,219 Setting DEBUG logging. 2016-02-27 05:53:06,220 attempt 1/10 2016-02-27 05:53:06,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e0140b6d118?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 05:53:06,490 unpacking tar archive at: mozilla-central-5e0140b6d118/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:06.223987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:06.224388) ========= echo 5e0140b6d11821e0c2a2de25bc5431783f03380a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e0140b6d11821e0c2a2de25bc5431783f03380a'] 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5e0140b6d11821e0c2a2de25bc5431783f03380a program finished with exit code 0 elapsedTime=0.004628 script_repo_revision: '5e0140b6d11821e0c2a2de25bc5431783f03380a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:06.278515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:06.279080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:53:06.289466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-02-27 05:53:06.290155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:06 INFO - MultiFileLogger online at 20160227 05:53:06 in /builds/slave/test-pgo 05:53:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:53:06 INFO - {'append_to_log': False, 05:53:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:53:06 INFO - 'blob_upload_branch': 'Firefox', 05:53:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:53:06 INFO - 'branch': 'Firefox', 05:53:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:06 INFO - 'config_files': ('talos/linux_config.py',), 05:53:06 INFO - 'default_actions': ('clobber', 05:53:06 INFO - 'read-buildbot-config', 05:53:06 INFO - 'download-and-extract', 05:53:06 INFO - 'populate-webroot', 05:53:06 INFO - 'create-virtualenv', 05:53:06 INFO - 'install', 05:53:06 INFO - 'run-tests'), 05:53:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:06 INFO - 'download_minidump_stackwalk': True, 05:53:06 INFO - 'download_symbols': 'ondemand', 05:53:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:06 INFO - 'installer_path': 'installer.exe', 05:53:06 INFO - 'log_level': 'info', 05:53:06 INFO - 'log_name': 'talos', 05:53:06 INFO - 'log_to_console': True, 05:53:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:06 INFO - 'opt_config_files': (), 05:53:06 INFO - 'pip_index': False, 05:53:06 INFO - 'sps_profile': False, 05:53:06 INFO - 'sps_profile_interval': 0, 05:53:06 INFO - 'suite': 'dromaeojs', 05:53:06 INFO - 'system_bits': '32', 05:53:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:06 INFO - 'title': 'talos-linux64-ix-012', 05:53:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:06 INFO - 'use_talos_json': True, 05:53:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:53:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:06 INFO - 'work_dir': 'build'} 05:53:06 INFO - ##### 05:53:06 INFO - ##### Running clobber step. 05:53:06 INFO - ##### 05:53:06 INFO - Running pre-action listener: _resource_record_pre_action 05:53:06 INFO - Running main action method: clobber 05:53:06 INFO - rmtree: /builds/slave/test-pgo/build 05:53:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:53:07 INFO - Running post-action listener: _resource_record_post_action 05:53:07 INFO - ##### 05:53:07 INFO - ##### Running read-buildbot-config step. 05:53:07 INFO - ##### 05:53:07 INFO - Running pre-action listener: _resource_record_pre_action 05:53:07 INFO - Running main action method: read_buildbot_config 05:53:07 INFO - Using buildbot properties: 05:53:07 INFO - { 05:53:07 INFO - "project": "", 05:53:07 INFO - "product": "firefox", 05:53:07 INFO - "script_repo_revision": "production", 05:53:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:53:07 INFO - "repository": "", 05:53:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:53:07 INFO - "buildid": "20160227030205", 05:53:07 INFO - "stage_platform": "linux64-pgo", 05:53:07 INFO - "basedir": "/builds/slave/test-pgo", 05:53:07 INFO - "nightly_build": "True", 05:53:07 INFO - "buildnumber": 692, 05:53:07 INFO - "slavename": "talos-linux64-ix-012", 05:53:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:53:07 INFO - "platform": "ubuntu64_hw", 05:53:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:53:07 INFO - "branch": "mozilla-central", 05:53:07 INFO - "repo_path": "mozilla-central", 05:53:07 INFO - "revision": "5e0140b6d11821e0c2a2de25bc5431783f03380a", 05:53:07 INFO - "pgo_build": "True", 05:53:07 INFO - "builduid": "76621c0ab39b4892aa621e6e6e034181", 05:53:07 INFO - "slavebuilddir": "test" 05:53:07 INFO - } 05:53:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:53:07 INFO - Running post-action listener: _resource_record_post_action 05:53:07 INFO - ##### 05:53:07 INFO - ##### Running download-and-extract step. 05:53:07 INFO - ##### 05:53:07 INFO - Running pre-action listener: _resource_record_pre_action 05:53:07 INFO - Running main action method: download_and_extract 05:53:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:07 INFO - https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:53:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/test_packages.json 05:53:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/test_packages.json 05:53:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:53:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:53:08 INFO - Downloaded 1448 bytes. 05:53:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:53:08 INFO - Using the following test package requirements: 05:53:08 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:08 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:53:08 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:53:08 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'jsshell-linux-x86_64.zip'], 05:53:08 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:53:08 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:08 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:53:08 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:53:08 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:53:08 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:08 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:53:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:08 INFO - https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:53:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:53:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:53:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:53:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:09 INFO - Downloaded 23371764 bytes. 05:53:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:53:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:53:10 INFO - Return code: 0 05:53:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:10 INFO - https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:53:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:53:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:53:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:11 INFO - Downloaded 23371764 bytes. 05:53:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:53:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:53:13 INFO - Return code: 0 05:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:13 INFO - https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:53:14 INFO - Downloaded 10713410 bytes. 05:53:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:53:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:53:14 INFO - Return code: 0 05:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:14 INFO - https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:53:15 INFO - Downloaded 56625631 bytes. 05:53:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:53:15 INFO - mkdir: /builds/slave/test-pgo/properties 05:53:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:53:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:53:15 INFO - Contents: 05:53:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:53:16 INFO - Running post-action listener: _resource_record_post_action 05:53:16 INFO - Running post-action listener: set_extra_try_arguments 05:53:16 INFO - ##### 05:53:16 INFO - ##### Running populate-webroot step. 05:53:16 INFO - ##### 05:53:16 INFO - Running pre-action listener: _resource_record_pre_action 05:53:16 INFO - Running main action method: populate_webroot 05:53:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:16 INFO - '--tppagecycles', 05:53:16 INFO - '7'], 05:53:16 INFO - 'tests': ['tsvgm']}}, 05:53:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:53:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:53:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'tests': ['damp', 'tps']}, 05:53:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['damp', 'tps']}, 05:53:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:53:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:16 INFO - 'other': {'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore']}, 05:53:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore']}, 05:53:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore']}, 05:53:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore']}, 05:53:16 INFO - 'other_l64': {'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore']}, 05:53:16 INFO - 'other_nol64': {'tests': ['a11yr', 05:53:16 INFO - 'ts_paint', 05:53:16 INFO - 'tpaint', 05:53:16 INFO - 'sessionrestore', 05:53:16 INFO - 'sessionrestore_no_auto_restore']}, 05:53:16 INFO - 'svgr': {'tests': ['tsvgx', 05:53:16 INFO - 'tsvgr_opacity', 05:53:16 INFO - 'tart', 05:53:16 INFO - 'tscrollx', 05:53:16 INFO - 'cart']}, 05:53:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['tsvgx', 05:53:16 INFO - 'tsvgr_opacity', 05:53:16 INFO - 'tart', 05:53:16 INFO - 'tscrollx', 05:53:16 INFO - 'cart']}, 05:53:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'tests': ['tp5o']}, 05:53:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--e10s'], 05:53:16 INFO - 'tests': ['tp5o']}, 05:53:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--xperf_path', 05:53:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:16 INFO - 'tests': ['tp5n']}, 05:53:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:16 INFO - 'talos_options': ['--e10s', 05:53:16 INFO - '--xperf_path', 05:53:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:16 INFO - 'tests': ['tp5n']}}, 05:53:16 INFO - 'talos.zip': {'path': '', 05:53:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:16 INFO - Running post-action listener: _resource_record_post_action 05:53:16 INFO - ##### 05:53:16 INFO - ##### Running create-virtualenv step. 05:53:16 INFO - ##### 05:53:16 INFO - Running pre-action listener: _resource_record_pre_action 05:53:16 INFO - Running main action method: create_virtualenv 05:53:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:53:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:53:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:53:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:16 INFO - Using real prefix '/usr' 05:53:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:53:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:19 INFO - Installing pip.................done. 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:53:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:19 INFO - Using env: {'DISPLAY': ':0', 05:53:19 INFO - 'HOME': '/home/cltbld', 05:53:19 INFO - 'LANG': 'en_US.UTF-8', 05:53:19 INFO - 'LANGUAGE': 'en_US:en', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MAIL': '/var/mail/cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SHLVL': '1', 05:53:19 INFO - 'TERM': 'linux', 05:53:19 INFO - 'TMOUT': '86400', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - '_': '/tools/buildbot/bin/python'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:53:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:53:19 INFO - Using env: {'DISPLAY': ':0', 05:53:19 INFO - 'HOME': '/home/cltbld', 05:53:19 INFO - 'LANG': 'en_US.UTF-8', 05:53:19 INFO - 'LANGUAGE': 'en_US:en', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MAIL': '/var/mail/cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SHLVL': '1', 05:53:19 INFO - 'TERM': 'linux', 05:53:19 INFO - 'TMOUT': '86400', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - '_': '/tools/buildbot/bin/python'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 INFO - Downloading/unpacking psutil>=0.7.1 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:21 INFO - Installing collected packages: psutil 05:53:21 INFO - Running setup.py install for psutil 05:53:21 INFO - building 'psutil._psutil_linux' extension 05:53:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:53:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:53:21 INFO - building 'psutil._psutil_posix' extension 05:53:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:53:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:53:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:21 INFO - Successfully installed psutil 05:53:21 INFO - Cleaning up... 05:53:22 INFO - Return code: 0 05:53:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:53:22 INFO - Using env: {'DISPLAY': ':0', 05:53:22 INFO - 'HOME': '/home/cltbld', 05:53:22 INFO - 'LANG': 'en_US.UTF-8', 05:53:22 INFO - 'LANGUAGE': 'en_US:en', 05:53:22 INFO - 'LOGNAME': 'cltbld', 05:53:22 INFO - 'MAIL': '/var/mail/cltbld', 05:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:22 INFO - 'MOZ_NO_REMOTE': '1', 05:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:22 INFO - 'NO_EM_RESTART': '1', 05:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:22 INFO - 'SHELL': '/bin/bash', 05:53:22 INFO - 'SHLVL': '1', 05:53:22 INFO - 'TERM': 'linux', 05:53:22 INFO - 'TMOUT': '86400', 05:53:22 INFO - 'USER': 'cltbld', 05:53:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:22 INFO - '_': '/tools/buildbot/bin/python'} 05:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:53:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:53:24 INFO - Installing collected packages: mozsystemmonitor 05:53:24 INFO - Running setup.py install for mozsystemmonitor 05:53:24 INFO - Successfully installed mozsystemmonitor 05:53:24 INFO - Cleaning up... 05:53:24 INFO - Return code: 0 05:53:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:24 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:53:24 INFO - Using env: {'DISPLAY': ':0', 05:53:24 INFO - 'HOME': '/home/cltbld', 05:53:24 INFO - 'LANG': 'en_US.UTF-8', 05:53:24 INFO - 'LANGUAGE': 'en_US:en', 05:53:24 INFO - 'LOGNAME': 'cltbld', 05:53:24 INFO - 'MAIL': '/var/mail/cltbld', 05:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:24 INFO - 'MOZ_NO_REMOTE': '1', 05:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:24 INFO - 'NO_EM_RESTART': '1', 05:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:24 INFO - 'SHELL': '/bin/bash', 05:53:24 INFO - 'SHLVL': '1', 05:53:24 INFO - 'TERM': 'linux', 05:53:24 INFO - 'TMOUT': '86400', 05:53:24 INFO - 'USER': 'cltbld', 05:53:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:24 INFO - '_': '/tools/buildbot/bin/python'} 05:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:53:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:26 INFO - Downloading docopt-0.6.1.tar.gz 05:53:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:27 INFO - Running setup.py install for blobuploader 05:53:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:53:27 INFO - Running setup.py install for requests 05:53:27 INFO - Running setup.py install for docopt 05:53:27 INFO - Successfully installed blobuploader requests docopt 05:53:27 INFO - Cleaning up... 05:53:27 INFO - Return code: 0 05:53:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:27 INFO - Using env: {'DISPLAY': ':0', 05:53:27 INFO - 'HOME': '/home/cltbld', 05:53:27 INFO - 'LANG': 'en_US.UTF-8', 05:53:27 INFO - 'LANGUAGE': 'en_US:en', 05:53:27 INFO - 'LOGNAME': 'cltbld', 05:53:27 INFO - 'MAIL': '/var/mail/cltbld', 05:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:27 INFO - 'MOZ_NO_REMOTE': '1', 05:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:27 INFO - 'NO_EM_RESTART': '1', 05:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:27 INFO - 'SHELL': '/bin/bash', 05:53:27 INFO - 'SHLVL': '1', 05:53:27 INFO - 'TERM': 'linux', 05:53:27 INFO - 'TMOUT': '86400', 05:53:27 INFO - 'USER': 'cltbld', 05:53:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:27 INFO - '_': '/tools/buildbot/bin/python'} 05:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:27 INFO - Running setup.py (path:/tmp/pip-rTkioK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:27 INFO - Running setup.py (path:/tmp/pip-mbZGgQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:27 INFO - Running setup.py (path:/tmp/pip-Pkomc3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:28 INFO - Running setup.py (path:/tmp/pip-iglubl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:28 INFO - Running setup.py (path:/tmp/pip-X_voQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:28 INFO - Running setup.py (path:/tmp/pip-v0Sq3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:28 INFO - Running setup.py (path:/tmp/pip-Lc38Ve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:28 INFO - Running setup.py (path:/tmp/pip-03PwzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:28 INFO - Running setup.py (path:/tmp/pip-S5xLNM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:28 INFO - Running setup.py (path:/tmp/pip-2cX0jp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:28 INFO - Running setup.py (path:/tmp/pip-W6G6C1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:28 INFO - Running setup.py (path:/tmp/pip-HuXlq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:28 INFO - Running setup.py (path:/tmp/pip-1GA6F7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:28 INFO - Running setup.py (path:/tmp/pip-bxjfip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:28 INFO - Running setup.py (path:/tmp/pip-gPfPCK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:28 INFO - Running setup.py (path:/tmp/pip-TyJcdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:28 INFO - Running setup.py (path:/tmp/pip-T5OPlo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:29 INFO - Running setup.py install for manifestparser 05:53:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Running setup.py install for mozcrash 05:53:29 INFO - Running setup.py install for mozdebug 05:53:29 INFO - Running setup.py install for mozdevice 05:53:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Running setup.py install for mozfile 05:53:29 INFO - Running setup.py install for mozhttpd 05:53:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Running setup.py install for mozinfo 05:53:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Running setup.py install for mozInstall 05:53:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:53:29 INFO - Running setup.py install for mozleak 05:53:29 INFO - Running setup.py install for mozlog 05:53:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Running setup.py install for moznetwork 05:53:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Running setup.py install for mozprocess 05:53:30 INFO - Running setup.py install for mozprofile 05:53:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Running setup.py install for mozrunner 05:53:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Running setup.py install for mozscreenshot 05:53:30 INFO - Running setup.py install for moztest 05:53:30 INFO - Running setup.py install for mozversion 05:53:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:53:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:30 INFO - Cleaning up... 05:53:30 INFO - Return code: 0 05:53:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:30 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:30 INFO - Using env: {'DISPLAY': ':0', 05:53:30 INFO - 'HOME': '/home/cltbld', 05:53:30 INFO - 'LANG': 'en_US.UTF-8', 05:53:30 INFO - 'LANGUAGE': 'en_US:en', 05:53:30 INFO - 'LOGNAME': 'cltbld', 05:53:30 INFO - 'MAIL': '/var/mail/cltbld', 05:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:30 INFO - 'MOZ_NO_REMOTE': '1', 05:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:30 INFO - 'NO_EM_RESTART': '1', 05:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:30 INFO - 'SHELL': '/bin/bash', 05:53:30 INFO - 'SHLVL': '1', 05:53:30 INFO - 'TERM': 'linux', 05:53:30 INFO - 'TMOUT': '86400', 05:53:30 INFO - 'USER': 'cltbld', 05:53:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:30 INFO - '_': '/tools/buildbot/bin/python'} 05:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:31 INFO - Running setup.py (path:/tmp/pip-LhCPmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:31 INFO - Running setup.py (path:/tmp/pip-aesb7b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:31 INFO - Running setup.py (path:/tmp/pip-nEz1NY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:31 INFO - Running setup.py (path:/tmp/pip-DaVxhC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:31 INFO - Running setup.py (path:/tmp/pip-UHS7eQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:31 INFO - Running setup.py (path:/tmp/pip-w2QizF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:31 INFO - Running setup.py (path:/tmp/pip-fwkDMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:31 INFO - Running setup.py (path:/tmp/pip-kG5dK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:31 INFO - Running setup.py (path:/tmp/pip-iD6wvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:31 INFO - Running setup.py (path:/tmp/pip-xZn9_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:31 INFO - Running setup.py (path:/tmp/pip-6Vbvtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:31 INFO - Running setup.py (path:/tmp/pip-FJUbF2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:31 INFO - Running setup.py (path:/tmp/pip-i6UVvw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:53:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:31 INFO - Running setup.py (path:/tmp/pip-5Wa95U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:32 INFO - Running setup.py (path:/tmp/pip-j5xfQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:32 INFO - Running setup.py (path:/tmp/pip-96NSz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:53:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:32 INFO - Running setup.py (path:/tmp/pip-8Aoizn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:32 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:34 INFO - Downloading blessings-1.6.tar.gz 05:53:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:34 INFO - Installing collected packages: blessings 05:53:34 INFO - Running setup.py install for blessings 05:53:34 INFO - Successfully installed blessings 05:53:34 INFO - Cleaning up... 05:53:34 INFO - Return code: 0 05:53:34 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:53:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:34 INFO - Reading from file tmpfile_stdout 05:53:34 INFO - Current package versions: 05:53:34 INFO - argparse == 1.2.1 05:53:34 INFO - blessings == 1.6 05:53:34 INFO - blobuploader == 1.2.4 05:53:34 INFO - docopt == 0.6.1 05:53:34 INFO - manifestparser == 1.1 05:53:34 INFO - mozInstall == 1.12 05:53:34 INFO - mozcrash == 0.16 05:53:34 INFO - mozdebug == 0.1 05:53:34 INFO - mozdevice == 0.48 05:53:34 INFO - mozfile == 1.2 05:53:34 INFO - mozhttpd == 0.7 05:53:34 INFO - mozinfo == 0.9 05:53:34 INFO - mozleak == 0.1 05:53:34 INFO - mozlog == 3.1 05:53:34 INFO - moznetwork == 0.27 05:53:34 INFO - mozprocess == 0.22 05:53:34 INFO - mozprofile == 0.28 05:53:34 INFO - mozrunner == 6.11 05:53:34 INFO - mozscreenshot == 0.1 05:53:34 INFO - mozsystemmonitor == 0.0 05:53:34 INFO - moztest == 0.7 05:53:34 INFO - mozversion == 1.4 05:53:34 INFO - psutil == 3.1.1 05:53:34 INFO - requests == 1.2.3 05:53:34 INFO - wsgiref == 0.1.2 05:53:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:34 INFO - Using env: {'DISPLAY': ':0', 05:53:34 INFO - 'HOME': '/home/cltbld', 05:53:34 INFO - 'LANG': 'en_US.UTF-8', 05:53:34 INFO - 'LANGUAGE': 'en_US:en', 05:53:34 INFO - 'LOGNAME': 'cltbld', 05:53:34 INFO - 'MAIL': '/var/mail/cltbld', 05:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:34 INFO - 'MOZ_NO_REMOTE': '1', 05:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:34 INFO - 'NO_EM_RESTART': '1', 05:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:34 INFO - 'SHELL': '/bin/bash', 05:53:34 INFO - 'SHLVL': '1', 05:53:34 INFO - 'TERM': 'linux', 05:53:34 INFO - 'TMOUT': '86400', 05:53:34 INFO - 'USER': 'cltbld', 05:53:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:34 INFO - '_': '/tools/buildbot/bin/python'} 05:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 05:53:34 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 2)) 05:53:34 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 3)) 05:53:34 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 4)) 05:53:34 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 5)) 05:53:34 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 6)) 05:53:34 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 7)) 05:53:34 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 8)) 05:53:34 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 9)) 05:53:34 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:53:34 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 4)) 05:53:34 INFO - Cleaning up... 05:53:34 INFO - Return code: 0 05:53:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:34 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:53:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:53:34 INFO - Using env: {'DISPLAY': ':0', 05:53:34 INFO - 'HOME': '/home/cltbld', 05:53:34 INFO - 'LANG': 'en_US.UTF-8', 05:53:34 INFO - 'LANGUAGE': 'en_US:en', 05:53:34 INFO - 'LOGNAME': 'cltbld', 05:53:34 INFO - 'MAIL': '/var/mail/cltbld', 05:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:34 INFO - 'MOZ_NO_REMOTE': '1', 05:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:34 INFO - 'NO_EM_RESTART': '1', 05:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:34 INFO - 'SHELL': '/bin/bash', 05:53:34 INFO - 'SHLVL': '1', 05:53:34 INFO - 'TERM': 'linux', 05:53:34 INFO - 'TMOUT': '86400', 05:53:34 INFO - 'USER': 'cltbld', 05:53:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:34 INFO - '_': '/tools/buildbot/bin/python'} 05:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:34 INFO - Downloading/unpacking jsonschema 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:36 INFO - Downloading/unpacking functools32 (from jsonschema) 05:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:37 INFO - warning: no files found matching '*.txt' 05:53:37 INFO - no previously-included directories found matching 'build' 05:53:37 INFO - no previously-included directories found matching 'dist' 05:53:37 INFO - no previously-included directories found matching '.git*' 05:53:37 INFO - Installing collected packages: jsonschema, functools32 05:53:37 INFO - Running setup.py install for functools32 05:53:37 INFO - warning: no files found matching '*.txt' 05:53:37 INFO - no previously-included directories found matching 'build' 05:53:37 INFO - no previously-included directories found matching 'dist' 05:53:37 INFO - no previously-included directories found matching '.git*' 05:53:37 INFO - Successfully installed jsonschema functools32 05:53:37 INFO - Cleaning up... 05:53:37 INFO - Return code: 0 05:53:37 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:37 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 0x7f70f8c5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2921670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:53:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:53:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:53:37 INFO - Using env: {'DISPLAY': ':0', 05:53:37 INFO - 'HOME': '/home/cltbld', 05:53:37 INFO - 'LANG': 'en_US.UTF-8', 05:53:37 INFO - 'LANGUAGE': 'en_US:en', 05:53:37 INFO - 'LOGNAME': 'cltbld', 05:53:37 INFO - 'MAIL': '/var/mail/cltbld', 05:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:37 INFO - 'MOZ_NO_REMOTE': '1', 05:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:37 INFO - 'NO_EM_RESTART': '1', 05:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:37 INFO - 'SHELL': '/bin/bash', 05:53:37 INFO - 'SHLVL': '1', 05:53:37 INFO - 'TERM': 'linux', 05:53:37 INFO - 'TMOUT': '86400', 05:53:37 INFO - 'USER': 'cltbld', 05:53:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:37 INFO - '_': '/tools/buildbot/bin/python'} 05:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:37 INFO - Downloading/unpacking flake8 05:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:53:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:53:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:53:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:39 INFO - no previously-included directories found matching 'docs/_build' 05:53:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:53:40 INFO - Running setup.py install for pep8 05:53:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:53:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:53:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:53:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:53:40 INFO - no previously-included directories found matching 'docs/_build' 05:53:40 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:53:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:53:40 INFO - Cleaning up... 05:53:40 INFO - Return code: 0 05:53:40 INFO - Running post-action listener: _resource_record_post_action 05:53:40 INFO - Running post-action listener: _start_resource_monitoring 05:53:40 INFO - Starting resource monitoring. 05:53:40 INFO - ##### 05:53:40 INFO - ##### Running install step. 05:53:40 INFO - ##### 05:53:40 INFO - Running pre-action listener: _resource_record_pre_action 05:53:40 INFO - Running main action method: install 05:53:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:53:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:53:40 INFO - Reading from file tmpfile_stdout 05:53:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:53:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:53:40 INFO - Reading from file tmpfile_stdout 05:53:40 INFO - Output received: 05:53:40 INFO - Usage: mozinstall [options] installer 05:53:40 INFO - Options: 05:53:40 INFO - -h, --help show this help message and exit 05:53:40 INFO - -d DEST, --destination=DEST 05:53:40 INFO - Directory to install application into. [default: 05:53:40 INFO - "/builds/slave/test-pgo"] 05:53:40 INFO - --app=APP Application being installed. [default: firefox] 05:53:40 INFO - mkdir: /builds/slave/test-pgo/build/application 05:53:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:53:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:53:56 INFO - Reading from file tmpfile_stdout 05:53:56 INFO - Output received: 05:53:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:53:56 INFO - Running post-action listener: _resource_record_post_action 05:53:56 INFO - ##### 05:53:56 INFO - ##### Running run-tests step. 05:53:56 INFO - ##### 05:53:56 INFO - Running pre-action listener: _resource_record_pre_action 05:53:56 INFO - Running main action method: run_tests 05:53:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:53:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:53:56 INFO - Python 2.7.3 05:53:56 INFO - Return code: 0 05:53:56 INFO - grabbing minidump binary from tooltool 05:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:56 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 0x29b08c0>, '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 0x29b17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29b1c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:53:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:53:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:53:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:56 INFO - Return code: 0 05:53:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:53:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:53:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:53:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:53:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:53:57 INFO - Return code: 0 05:53:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:53:57 INFO - Using env: {'DISPLAY': ':0', 05:53:57 INFO - 'HOME': '/home/cltbld', 05:53:57 INFO - 'LANG': 'en_US.UTF-8', 05:53:57 INFO - 'LANGUAGE': 'en_US:en', 05:53:57 INFO - 'LOGNAME': 'cltbld', 05:53:57 INFO - 'MAIL': '/var/mail/cltbld', 05:53:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:57 INFO - 'MOZ_NO_REMOTE': '1', 05:53:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:57 INFO - 'NO_EM_RESTART': '1', 05:53:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:53:57 INFO - 'SHELL': '/bin/bash', 05:53:57 INFO - 'SHLVL': '1', 05:53:57 INFO - 'TERM': 'linux', 05:53:57 INFO - 'TMOUT': '86400', 05:53:57 INFO - 'USER': 'cltbld', 05:53:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365', 05:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:57 INFO - '_': '/tools/buildbot/bin/python'} 05:53:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:53:58 INFO - mozversion application_buildid: 20160227030205 05:53:58 INFO - mozversion application_changeset: 5e0140b6d11821e0c2a2de25bc5431783f03380a 05:53:58 INFO - mozversion application_display_name: Nightly 05:53:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:58 INFO - mozversion application_name: Firefox 05:53:58 INFO - mozversion application_remotingname: firefox 05:53:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:58 INFO - mozversion application_vendor: Mozilla 05:53:58 INFO - mozversion application_version: 47.0a1 05:53:58 INFO - mozversion platform_buildid: 20160227030205 05:53:58 INFO - mozversion platform_changeset: 5e0140b6d11821e0c2a2de25bc5431783f03380a 05:53:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:58 INFO - mozversion platform_version: 47.0a1 05:53:58 INFO - using testdate: 1456581238 05:53:58 INFO - actual date: 1456581238 05:53:58 INFO - starting webserver on 'localhost:49255' 05:53:58 INFO - SUITE-START | Running 2 tests 05:53:58 INFO - TEST-START | dromaeo_css 05:53:58 INFO - operating with platform_type : linux_ 05:53:58 INFO - Initialising browser for dromaeo_css test... 05:53:58 INFO - TEST-INFO | started process 3238 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpioR5Pp/profile http://localhost:49255/getInfo.html) 05:54:01 INFO - PROCESS | 3238 | __metrics Screen width/height:1600/1200 05:54:01 INFO - PROCESS | 3238 | colorDepth:24 05:54:01 INFO - PROCESS | 3238 | Browser inner width/height: 1024/697 05:54:01 INFO - PROCESS | 3238 | __metrics 05:54:02 INFO - PROCESS | 3238 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:02 INFO - PROCESS | 3238 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:54:02 INFO - PROCESS | 3238 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:54:02 INFO - PROCESS | 3238 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:54:02 INFO - PROCESS | 3238 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:54:02 INFO - PROCESS | 3238 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:54:02 INFO - PROCESS | 3238 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:54:02 INFO - PROCESS | 3238 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:54:03 INFO - TEST-INFO | 3238: exit 0 05:54:03 INFO - Browser initialized. 05:54:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:03 INFO - TEST-INFO | started process 3332 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpioR5Pp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:15 INFO - PROCESS | 3332 | RSS: Main: 151285760 05:54:15 INFO - PROCESS | 3332 | 05:55:06 INFO - PROCESS | 3332 | 1456581306477 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:57:14 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:49255/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49255/tests/dromaeo/cssquery-ext.html) 05:57:15 INFO - PROCESS | 3332 | RSS: Main: 254201856 05:57:15 INFO - PROCESS | 3332 | 06:00:17 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:49255/tests/dromaeo/cssquery-ext.html (next: http://localhost:49255/tests/dromaeo/cssquery-jquery.html) 06:00:17 INFO - PROCESS | 3332 | RSS: Main: 231264256 06:00:17 INFO - PROCESS | 3332 | 06:03:19 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:49255/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49255/tests/dromaeo/cssquery-mootools.html) 06:03:20 INFO - PROCESS | 3332 | RSS: Main: 226144256 06:03:20 INFO - PROCESS | 3332 | 06:06:22 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:49255/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49255/tests/dromaeo/cssquery-prototype.html) 06:06:22 INFO - PROCESS | 3332 | RSS: Main: 197132288 06:06:22 INFO - PROCESS | 3332 | 06:09:25 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:49255/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49255/tests/dromaeo/cssquery-yui.html) 06:09:26 INFO - PROCESS | 3332 | RSS: Main: 213893120 06:09:26 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | Cycle 1(1): loaded http://localhost:49255/tests/dromaeo/cssquery-yui.html (next: http://localhost:49255/tests/dromaeo/cssquery-dojo.html) 06:12:29 INFO - PROCESS | 3332 | RSS: Main: 307798016 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | __start_tp_report 06:12:29 INFO - PROCESS | 3332 | _x_x_mozilla_page_load 06:12:29 INFO - PROCESS | 3332 | _x_x_mozilla_page_load_details 06:12:29 INFO - PROCESS | 3332 | |i|pagename|runs| 06:12:29 INFO - PROCESS | 3332 | |0;dojo.html;3057.4038062577797;3077.73839223666;3114;3122.344307695384;3140.7487401007916;4895.339129217555;4902.534259245375;4932.926006109911;4984.352034235553;5043.84868453947;4999.575036121934;5007.899842003158;5062.873428164297;5063.569596584295;5071.74641267936;4506.481754598214;4587.472440669324;4647.976760116195;4660;4687.953120468803;4533.909321813562;4717.882052948687;4725.291206319062;4737.478877323491;4800.927986080212;4524.3213517972235;4553.2942393929;4581;4602.033572949685;4626.9074618507775;4594.058218065288;4596.701214421052;4605.677602567822;4621.8151273949;4656.231721765905;4506.909861802746;4561.2245918193985;4578.725276483422;4583.495815460296;4590;4815;4820.469748327681;4847.418309802811;4856.2958371036;4874.926876096862;5289.1008528549855;5289.338832645919;5291.497307755757;5304.177852432879;5336.59975501835;5322.680639161663;5327.46725327468;5333;5397;5464.9180262296095;5055.59555235584;5074;5078.949210507884;5082.059818933472;5086.262491938648;5464.043792336325;5490.945090549123;5495.835124946258;5498.532624726943;5499.312585926759;5280.102382594968;5289.68261904287;5341.118715411992;5363.624546281723;5386.8383948481605;5362.034833729888;5382.3541175059245;5390.191471279261;5393.83818485446;5400.729963501809;5350.411454739976;5356.705381204071;5358.812441564526;5362.115250983544;5407.837764866981;5291.206319052096;5363.30277063987;5386.865328366822;5399.811006614749;5458.099413596791;4185.058361868555;4185.539590645027;4186.434831297735;4201.894952626148;4230.344296634026;3738.43923411485;3791.1659434924272;3792.469054332396;3815.08437974884;3857.96142038576;4936.432310284292;4949.950500495021;4965.90068198634;4999.475055119233;5012.022655582199;5266.3943646480375;5290.470952904756;5294.788208471695;5299.49654782795;5319.521243088141;4839.68542044773;4914.606831453475;4916.754162291871;4920.237363208708;4922.1140194765285;4612.339557759204;4619.284010978304;4631.0506346198945;4635.212013957568;4673.60274376675;5550.250716153268;5551.417101204396;5551.611387202857;5552.056150454432;5593.608447408642;5242.030224408497;5253.474652534716;5329.54698850602;5389.164679474688;5395.406505284337;5578.246936663499;5601.6358936668985;5604.411536788742;5605.719714014202;5636.689982051026;5373.408925018323;5374.7312634367345;5380.381256155436;5384.811531596375;5437.184422336682;5299.258103865539;5315.04329220744;5369.979703856255;5409.540189083972;5453.972730136324;5239;5245.527902488794;5268.473152684701;5274.340707411574;5276.445973172762;5261.684298941923;5264.657797243167;5269.077911365573;5276.076686579757;5318.494742999409;5073.162928116967;5092.337996060489;5120.4111527174855;5124.641275110706;5168.457311982338;5257.89484210306;5267.868303292448;5268.6575372600655;5283.1546952487415;5302.337207849019;5003.474635163256;5184.844454666366;5198.584113271005;5199.740012999259;5245.213218017176 06:12:29 INFO - PROCESS | 3332 | |1;ext.html;525.3616855520544;525.5874138801042;564.3284491455169;587.239524815364;587.9088741245107;27993.300167495796;35221.2955740885;35584.33117516184;35765.642343576554;35831.104222394424;37922.9142397168;38509;38535;38567.22865542687;38584.22831543368;7379.151397589266;8361.372897032716;8652.8702069469;10034.397936123856;10227.335223210468;9987.75030624233;10142.087212150906;10156.085952264295;10158;10164.84752728706;10199.490025498695;10285.280030397875;10304.845427318596;10307.948460257689;10309.48452577372;10115.645952391667;10192.184625229964;10204.642837500653;10205.081542661159;10209.489525523693;10413.843792343121;10579.471026448648;10582.100521455686;10590;10594.046535811814;40124.799376002935;40761.59238407637;40768.18463630741;40768.38847417291;40774.388384174265;3366.5960084789735;3393.053598896863;3897.883063508071;4085.5097388313297;4101.405296232059;30259.546106808415;30672.233194170323;30920.845395773104;30938;32443.51334729981;3826.4260360945805;3882.747621404628;3992.1017771001584;4000.5599384067727;4051.2181932737626;281888;283119;283844;284012;284440.9999999979;55967.720161399746;56086.15870761942;56672.43327566754;56808.71595642078;56854.43145568574;61557.384426155164;61782.38217617856;61935.69032154811;62118.68940655268;62120.68939655273;13348.73302533944;15156.24218789056;15215.08709477435;15509.689806203813;15524.767128493082;10512.42181680015;10534.525946332433;10559.736006599896;10565.418901960466;10586.735331616617;18398.448046558624;18571.907140464482;18579.349722759638;18594.81405185958;18618.53453663642;6588.4729221662155;7623.69505219785;7737.690492380242;7853.842923141505;8045.436819422584;890.643742503004;938.8591711243369;979.7697541077841;994.2841154368842;1109.2623405435295;27835;27914.441711165662;28207.43585128286;28254.71745282562;28582.14253572396;1025.7538190834146;1061.7982583309147;1097.9121670266359;1106.2035334559105;1136.0570726297153;14249.145051296955;14473.78289325661;14603;14633.609807068311;14693.485727999469;306860;309670;312980;313702;315834;50926.23610645843;51128;51147.232791508155;51210.74394628003;51256.743716281926;1247.5446462041289;1270.2822905058797;1312.2389014371643;1363.1344096498597;1379.7102608452137;24414.51170976535;25515.234542963743;25821.870890645427;25938.61092083658;25965.480690386463;37910;37973.62026379811;38297.61702382941;38297.61702383052;38327.42508862425;182499;184259;194532;197387;197728;26475.60286595741;30497;30865.228369290948;30897.53653695241;31152.065438036894;35932.28135437329;36673.26653466969;36919.44620830636;36972.44541331936;37427.81286093661;32927.341453171284;33903.830480847435;34048.319033618696;34075.65924340725;35007.47488787619;33848.830755846066;34175.487367689006;34561.48157777686;34722.826385867906;34730.82634586912;34044;34695.65304346924;34924;35092.12269693278;35209.647903520636;29853.55219671663;31000;31198.532022019233;31531.211719706273;31584.684153158174;23337.416564585343;24029;24036.63631812952;24122;24154 06:12:29 INFO - PROCESS | 3332 | |2;jquery.html;345.77524609004155;348.99127521811965;349.90902365384994;350.23124242288173;357.53877498027543;16476.588085297873;17072.402465913696;17605.471835844914;18263.81736182638;18320.35878744244;10350.637727679532;10368.48157592121;10377;10736.78526429473;10877.564897404114;4745.833895813638;4962.776675049613;4975.8258460953875;4982.725950072744;4999.625028122887;3650.653187947141;5749.878773639142;6689.832754181136;6932.23745388007;6937.479689023344;6895.862082758342;6899.310068993111;6903.482238832083;6915.965420172917;6927.861442771142;6308.116863639094;6566.113574667406;6571.7371305147735;6592.044153597725;6604.636744979024;4135.152293779768;6266.154069200645;6509.967450162719;6513.772017979395;6524.184476940382;20701.27545535914;21274.787252127437;22411.103555857746;22482.213122540634;22520.54958900813;2390.6414037894283;2407.518496300747;2408.638704194367;2514.962275565868;2746.5056289867816;12987.610371688865;13205;13273.402696878664;13486.527971521047;13872.4451021959;1998.8043045037894;2060.536379314657;2064.1021155797275;2073.232903825579;2091.895405229732;66231;71775;72179.63910180469;72250.63874680645;74761.25238747598;14658.633534161518;14982.576655217737;15554.377824887104;15555.144467054195;15570.766438503431;24219.636705449433;24329.878350608134;24387.26838194857;24422.51154976926;24505.87747061289;8847.73456796297;8864.379493435526;9130.406523575946;9143.131402516883;9246.583903724348;7766.068071831416;7798.298153166243;7930.762077137695;7944.245296696805;7963.362930965509;7696.11494678108;7853.253940875607;7857.2928436441;7861.584914715292;7901.012373453318;2927.6779554249015;3054.7250747432836;3064.8161110333454;3169.9683003170135;3174.6031746031745;847.8007668197969;940.7507010642186;952.1620973543238;965.99034009659;1060.8726952765717;16173.110478923536;16507.174641267888;16736.330546778237;16739.246733897005;17103;916.8212198621205;933.290699068699;965.6185806606351;966.1787480641539;984.684900831727;9266.44401335922;9493.0981556752;9516.23870090391;9528.666496672584;9775.657851975147;415764;417170;421747;424478;426715;45214;67442.32557674458;70816;71526;72910;1049.8845127036172;1063.1494804156644;1067.4502631144967;1107.894749998749;1108.4679353910008;15103.622409439851;15212.46756363522;15262.015937927998;15540.378384864478;15753.527394178192;32879.178020549676;33211.66788332086;33424.158946488846;34961.30077398488;34965;46178.53821461742;47342.52657473381;47425.52574474211;48316.7584162091;48992.75503622459;7787.104482984303;7828.608569571385;7850.960745196237;7933.246341597539;7982.321502672338;11512.884871151517;11997.580084696994;12279.877201228232;12630.179038362478;12955.676108096995;10536.420496872439;10766.246362754846;10851.565937362417;10993;11073.905764171226;10544.736381590521;10694.786104278026;10886.29239099456;10943.507542160782;11021.393823339793;10861.837072443761;10948.288361256493;11027.952344527257;11141.713194607772;11231.494582743959;7532.510386824839;7599.734009309647;7826.295633393022;7836.451448398558;7843.294103530709;8270.007599088149;10677.359358438518;10693.786124277316;10920.2901811382;11148.832767508657 06:12:29 INFO - PROCESS | 3332 | |3;mootools.html;1348.4673553946186;1455.8616931391518;1466.1789397937152;1591.9363225470981;1743.1894169211323;7262.310080542353;7372;7391.0761154855645;7406.259374062591;7408.148062972759;7251.129864416277;7361.742339018136;7399.741009064684;7403.740869069584;7437.888431673529;1970.5172232802984;2194.5940001099766;2244.394013616323;2248.4491299631613;2274.192661605131;2243.4167116549734;2250.6849041134255;2254.199759085526;2254.289898681918;2255.458689914417;2102.9684554731693;2165.577712346093;2168.1327469012363;2168.8807115608633;2170.663547150194;2184.9016794244376;2197;2207.5253820428607;2218.3455880515126;2237.2505210754416;2190.6166420876443;2195.0232146694725;2196.516766311409;2204.9857065749775;2209.193644319828;7444.143923448819;7507.512011719221;7510.924890751132;7523.247675232487;7537.886931696029;4466.82132714691;4583;4591.816327346902;4595.586397224232;4595.8391456299205;2955.807872488303;2962.614860068177;3005.1735772662473;3012.8493575321368;3110.782245242834;986.8421052631544;987.456898705709;1006.9748256293651;1026.5688410867378;1044.5456226541403;10021.098101170857;10166.135878450266;10180.389176649425;10186.28695991281;10198.082172604501;4031.3549832026733;4168.583141685807;4196.097838964637;4203.810828512725;4215.156968606291;8794.560271986375;8864.601092950703;8890.4665720057;8895.644174233088;8898.86651700225;4064.04494943688;4626.83806066786;4631.8378856739855;4643.071385722869;4648.209804333272;3967.3850553164307;4042.0299128209017;4045.0494133878515;4077.5922407758985;4080.81636326366;3400.7449441292;3466.2894106708063;3489.2498112905846;3500.7374446916074;3547.840347184383;1060.2313322841032;1091.737982884118;1094.2996482251365;1095.1786160379716;1106.4136007915818;1296.6304603188235;1307.4247331174254;1319.9868001319865;1321.3393303348325;1341.6511706956067;7157.391621712109;7158.391536719333;7265.455090868206;7280.745173918994;7285.672144753499;482.6476672029368;486.10799183498676;489.96570240082855;493.1247036510151;497.72376331136564;5421.674699518042;5423.294971653739;5428.212909128154;5474.315710536183;5476.397596264408;8489.490630562186;8679.696210632725;8869.290456763443;8877.600507977157;8908.599113039929;8744.300455963508;8786.341024423195;8813.515256660945;8826.249768769727;8841.469511829311;6732.730690772412;7034.261402552658;7041.119860017498;7045.577265364094;7119.252478489788;6960.721571137098;6987.510874238755;6994.860102798018;7007.369336759716;7040.542364746275;7701.576413297323;7941.444098913252;7965.322947549524;8121.75634730959;8143.144969778325;8017.959910200411;8139.308158806568;8277.172282771675;8296.419250652638;8335.583220839055;5731.885362292647;6210.782622608187;6357.745690172342;6447.3552644735155;6543.934560654333;6772.93227067723;6778.118844550177;6803.557768745016;6817;6817.5568588041615;6116.724747386467;6325.177726895474;6350.206224221973;6418.4865210783955;6419.903701444388;6297.055441683784;6443.806685799434;6445.1943507061615;6474.611523308617;6564.310747371457;6697.899531506934;6719.059331693469;6730.798076057726;6741.764038258638;6744.730210791709;6088.634681919099;6093.025115981422;6101.450869421773;6112.205413296243;6158.846028849135;6216.191895053614;6332.176817013758;6335.936640633719;6351.460125889351;6353.650549219652 06:12:29 INFO - PROCESS | 3332 | |4;prototype.html;315.9352332771782;320.16117771438826;322.2154054876376;324.0473009352505;328.50887922555785;5894.0864166054225;5955.791547295846;5961.910571341428;5966.940330596693;5989.341172471025;5809.622374545652;5833.620814647045;5840.0947853082735;5841.386654401291;5843.590948633598;4318;4411.05162390086;4516.954830451703;4554.225781617133;4563.133004729108;4525.818967241306;4540.614047805941;4540.7502587357685;4542.954570454286;4548.5224051474615;4468.709533880287;4479.283314669654;4520.796564154621;4549.795259213327;4551.953050798318;4309.849155279566;4330.17726631939;4474.932876006863;4497.482789479219;4527.366168736379;3879.8836034919;3903.882883513499;3924.4309575111733;3929;3932.1152740633415;5647.548196144298;5674.09214525678;5675.006873797069;5681.176229446748;5692.743826527816;5228.5817134629515;5248.422673505911;5251.55361794248;5253.52718255355;5255.1329030709885;6245;6246.6876656167005;6252.2809876864285;6260.217472815898;6264.7807326743805;4134.545200027995;4285.0572873967985;4395.7142785718825;4414.05097903949;4420.80106395213;6449.516286278501;6523.18460192476;6569.638669873155;6600.207975043026;6614.669266536654;4367.388565600819;4372.3878656988045;4373.2565463871215;4375.190589740908;4380.211561918885;4422.181896349121;4428.180786554498;4428.247197976288;4430.5126436092005;4430.667699922518;5153.2270159476375;5161.458046905096;5168.431472538018;5170.663906846118;5172.844814655567;6161.568690191643;6302.275238347649;6310.400511951358;6316.684165791692;6318.336574659686;1524.7636616324487;1562.8515291047331;1564.9765253521207;1565.0218613366646;1565.1626379886707;939.9577019034023;956.3257903178243;962.3023308101571;996.1532697207316;1015.8425444056184;5840.415958404211;5939.554533410012;5952.0179170436395;5955.7617695292565;5964.7315870785915;6615.338466153443;6618.768343107968;6637.502187335969;6650.9667451662435;6652.135222421054;5992.280926288786;5998.850028749229;6002.279726432768;6002.789902353396;6006.978813601698;3462.480627905784;3517.138301116243;3519.3137338218803;3521.454174602941;3521.454174602941;6527.5757075789925;6546.083548303146;6623.602583844985;6672.232693240242;6804.4216241620015;6668.233153187349;6699.062131301622;6707.1616047994;6713.865722685519;6715.395614394728;6798.320167983162;6813.250542440328;6821.761238356634;6822.454203663596;6828.760993365208;6482.319356467503;6531.444827189552;6532.05285233629;6533.803985880431;6551;6237.407446292595;6464.515161362822;6474.902876456763;6484.870302594016;6497.512686548623;6818.454523638196;6845.760398386033;6846.246912839683;6859.622720750406;6869.553479023847;4295.463067116611;4332.740035597874;4348.326009468537;4349.934750978675;4354.042110735633;6558.376954189344;6563.442107420923;6568.868622627616;6569.178852643419;6579.572327798678;5928.4960778334325;6100.572959892765;6374.3306952771145;6444.871102578016;6461.741530338922;6209.161763161916;6320.841978950563;6355.205599300088;6366.331535188924;6367.87264254703;6243;6247.562670613013;6248.812535623939;6252.187215661935;6255.687215639109;6379.7129129190225;6402.391772781578;6403.903941440789;6405.167328247298;6407.295197528361;6094.8171554853425;6229.4393504584805;6242.750289988349;6256.499480041494;6256.937430625636 06:12:29 INFO - PROCESS | 3332 | |5;yui.html;739.9778006659799;758.8558173946954;798.7404093669555;816.2775943290187;831.8128421105253;13868.653283667913;14055.578332650037;14062.718745625081;14089.365978530965;14093.083949543272;14905.552833415015;15056.322465489053;15061;15080.547583572483;15114.773278400833;692.4460431654682;813.1461964936822;840.2815592668258;847.7329641163014;851.8040850604365;814.767791179514;820.8358328334327;829.4567058576642;830.1822704635929;830.7466222802043;868.3010176807667;884.4914174349775;885.6988623867884;887.2635712358759;887.9600417981206;710.3322876496103;859.3898332184157;866.3285953386113;876.6361959786681;879.1647934462286;627.3882964110002;639.1978067525226;647.0294558162756;647.2233320015999;647.4367300448592;13962.58112256634;13964.650883727887;13980.440782368692;14010.719785604231;14036.649083772885;12496.437660305308;12637.2417654941;12722.363881805873;12977.35113244334;12989.220646761225;11038.613648522343;11067.225294229407;11129.610463633815;11201.159913006475;11301.773964520746;3586.1891035023486;3609.6029436761937;3637.654422829827;3749.737518373715;3752.2683076800035;50218;50834.237486437734;50864.23703644448;53059.73470132663;53310.20034699521;10255.212113378982;10269.332493388056;10365.170786337076;10457.26799124054;11027.669169924915;18392.632147356977;18399.632007359778;18441.53896152607;18446.35437759672;18496.537586560175;7741.07107147146;7837.294643482114;7884.17216192303;7887;7935.325497332791;4211.957880421218;4219.346001369731;4298.677599180074;4357.8451710296795;4444.5777651123735;3130.98434507826;3143.0413723814454;3156.179393357698;3165.208697825544;3168.0970923287214;571.3087164530881;573.8852229554105;585.8916100521417;586.4809643465478;596.1683451585014;547.9589030822705;650.2067477677226;670.9765158219438;675.5035049238805;696.1993707236718;7475.663595138232;7512.699492020258;7516.699332026657;8006.15935326794;8116.6347514362;489.1000558971509;602.9553723917672;654.7348323928817;658.6937074260492;676.3844901139939;3993.5008123984503;4016.6184212499766;4033.253848038122;4195.643370313557;4198.624965226765;53631;54049;54480.45519544754;54684.72657636686;54787.45212547903;45398.319025214645;46260.5373946263;46539.534604654196;47160.29259561041;47884.28173577399;40698.18603627911;40873.386899196536;40881;41404.79297603493;41887;8326.79183020405;8551.57242137903;8561;8578.768146245326;8598.484090954562;32524.349513010082;32985.50521742224;33220.1694957628;33292.469002910104;33412.498812518315;37130.257394852495;40489.79755101206;41261.58738412578;41671.166576668904;42895.1420971585;9610.807783844144;9922;10099.899001009895;10139.442330671884;10270.43512606784;11039.668809935714;11271;11419.714507137389;11453.484593193492;11555.306681599131;10744.677659670222;11246.268992515461;11258.66224013281;11473.655790326304;11507;10100.141487973604;10266.486675666038;10722.142228621535;11105;11114.944425277821;10519.211059170746;11042.834357484484;11305.886941130813;11373.772524549628;11379;8417.537035463109;9577.281703872099;9662.17871480932;9667.274954378308;9670.951645241728;7930.325922296439;8055.395845311742;8700.173483519056;9058.547072646474;9366.906330936603 06:12:29 INFO - PROCESS | 3332 | __end_tp_report 06:12:29 INFO - PROCESS | 3332 | __start_cc_report 06:12:29 INFO - PROCESS | 3332 | _x_x_mozilla_cycle_collect,819 06:12:29 INFO - PROCESS | 3332 | __end_cc_report 06:12:29 INFO - PROCESS | 3332 | __startTimestamp1456582349341__endTimestamp 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | ------- Summary: start ------- 06:12:29 INFO - PROCESS | 3332 | Number of tests: 6 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | [#0] dojo.html Cycles:165 Average:4995.80 Median:5198.58 stddev:526.54 (10.1%) stddev-sans-first:505.72 06:12:29 INFO - PROCESS | 3332 | Values: 3057.4 3077.7 3114.0 3122.3 3140.7 4895.3 4902.5 4932.9 4984.4 5043.8 4999.6 5007.9 5062.9 5063.6 5071.7 4506.5 4587.5 4648.0 4660.0 4688.0 4533.9 4717.9 4725.3 4737.5 4800.9 4524.3 4553.3 4581.0 4602.0 4626.9 4594.1 4596.7 4605.7 4621.8 4656.2 4506.9 4561.2 4578.7 4583.5 4590.0 4815.0 4820.5 4847.4 4856.3 4874.9 5289.1 5289.3 5291.5 5304.2 5336.6 5322.7 5327.5 5333.0 5397.0 5464.9 5055.6 5074.0 5078.9 5082.1 5086.3 5464.0 5490.9 5495.8 5498.5 5499.3 5280.1 5289.7 5341.1 5363.6 5386.8 5362.0 5382.4 5390.2 5393.8 5400.7 5350.4 5356.7 5358.8 5362.1 5407.8 5291.2 5363.3 5386.9 5399.8 5458.1 4185.1 4185.5 4186.4 4201.9 4230.3 3738.4 3791.2 3792.5 3815.1 3858.0 4936.4 4950.0 4965.9 4999.5 5012.0 5266.4 5290.5 5294.8 5299.5 5319.5 4839.7 4914.6 4916.8 4920.2 4922.1 4612.3 4619.3 4631.1 4635.2 4673.6 5550.3 5551.4 5551.6 5552.1 5593.6 5242.0 5253.5 5329.5 5389.2 5395.4 5578.2 5601.6 5604.4 5605.7 5636.7 5373.4 5374.7 5380.4 5384.8 5437.2 5299.3 5315.0 5370.0 5409.5 5454.0 5239.0 5245.5 5268.5 5274.3 5276.4 5261.7 5264.7 5269.1 5276.1 5318.5 5073.2 5092.3 5120.4 5124.6 5168.5 5257.9 5267.9 5268.7 5283.2 5302.3 5003.5 5184.8 5198.6 5199.7 5245.2 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | [#1] ext.html Cycles:180 Average:42914.41 Median:31175.30 stddev:69825.90 (224.0%) stddev-sans-first:69949.24 06:12:29 INFO - PROCESS | 3332 | Values: 525.4 525.6 564.3 587.2 587.9 27993.3 35221.3 35584.3 35765.6 35831.1 37922.9 38509.0 38535.0 38567.2 38584.2 7379.2 8361.4 8652.9 10034.4 10227.3 9987.8 10142.1 10156.1 10158.0 10164.8 10199.5 10285.3 10304.8 10307.9 10309.5 10115.6 10192.2 10204.6 10205.1 10209.5 10413.8 10579.5 10582.1 10590.0 10594.0 40124.8 40761.6 40768.2 40768.4 40774.4 3366.6 3393.1 3897.9 4085.5 4101.4 30259.5 30672.2 30920.8 30938.0 32443.5 3826.4 3882.7 3992.1 4000.6 4051.2 281888.0 283119.0 283844.0 284012.0 284441.0 55967.7 56086.2 56672.4 56808.7 56854.4 61557.4 61782.4 61935.7 62118.7 62120.7 13348.7 15156.2 15215.1 15509.7 15524.8 10512.4 10534.5 10559.7 10565.4 10586.7 18398.4 18571.9 18579.3 18594.8 18618.5 6588.5 7623.7 7737.7 7853.8 8045.4 890.6 938.9 979.8 994.3 1109.3 27835.0 27914.4 28207.4 28254.7 28582.1 1025.8 1061.8 1097.9 1106.2 1136.1 14249.1 14473.8 14603.0 14633.6 14693.5 306860.0 309670.0 312980.0 313702.0 315834.0 50926.2 51128.0 51147.2 51210.7 51256.7 1247.5 1270.3 1312.2 1363.1 1379.7 24414.5 25515.2 25821.9 25938.6 25965.5 37910.0 37973.6 38297.6 38297.6 38327.4 182499.0 184259.0 194532.0 197387.0 197728.0 26475.6 30497.0 30865.2 30897.5 31152.1 35932.3 36673.3 36919.4 36972.4 37427.8 32927.3 33903.8 34048.3 34075.7 35007.5 33848.8 34175.5 34561.5 34722.8 34730.8 34044.0 34695.7 34924.0 35092.1 35209.6 29853.6 31000.0 31198.5 31531.2 31584.7 23337.4 24029.0 24036.6 24122.0 24154.0 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | [#2] jquery.html Cycles:180 Average:25590.37 Median:17655.60 stddev:68998.11 (390.8%) stddev-sans-first:69165.63 06:12:29 INFO - PROCESS | 3332 | Values: 345.8 349.0 349.9 350.2 357.5 16476.6 17072.4 17605.5 18263.8 18320.4 10350.6 10368.5 10377.0 10736.8 10877.6 4745.8 4962.8 4975.8 4982.7 4999.6 3650.7 5749.9 6689.8 6932.2 6937.5 6895.9 6899.3 6903.5 6916.0 6927.9 6308.1 6566.1 6571.7 6592.0 6604.6 4135.2 6266.2 6510.0 6513.8 6524.2 20701.3 21274.8 22411.1 22482.2 22520.5 2390.6 2407.5 2408.6 2515.0 2746.5 12987.6 13205.0 13273.4 13486.5 13872.4 1998.8 2060.5 2064.1 2073.2 2091.9 66231.0 71775.0 72179.6 72250.6 74761.3 14658.6 14982.6 15554.4 15555.1 15570.8 24219.6 24329.9 24387.3 24422.5 24505.9 8847.7 8864.4 9130.4 9143.1 9246.6 7766.1 7798.3 7930.8 7944.2 7963.4 7696.1 7853.3 7857.3 7861.6 7901.0 2927.7 3054.7 3064.8 3170.0 3174.6 847.8 940.8 952.2 966.0 1060.9 16173.1 16507.2 16736.3 16739.2 17103.0 916.8 933.3 965.6 966.2 984.7 9266.4 9493.1 9516.2 9528.7 9775.7 415764.0 417170.0 421747.0 424478.0 426715.0 45214.0 67442.3 70816.0 71526.0 72910.0 1049.9 1063.1 1067.5 1107.9 1108.5 15103.6 15212.5 15262.0 15540.4 15753.5 32879.2 33211.7 33424.2 34961.3 34965.0 46178.5 47342.5 47425.5 48316.8 48992.8 7787.1 7828.6 7851.0 7933.2 7982.3 11512.9 11997.6 12279.9 12630.2 12955.7 10536.4 10766.2 10851.6 10993.0 11073.9 10544.7 10694.8 10886.3 10943.5 11021.4 10861.8 10948.3 11028.0 11141.7 11231.5 7532.5 7599.7 7826.3 7836.5 7843.3 8270.0 10677.4 10693.8 10920.3 11148.8 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | [#3] mootools.html Cycles:180 Average:5191.21 Median:6097.24 stddev:2685.88 (44.1%) stddev-sans-first:2677.89 06:12:29 INFO - PROCESS | 3332 | Values: 1348.5 1455.9 1466.2 1591.9 1743.2 7262.3 7372.0 7391.1 7406.3 7408.1 7251.1 7361.7 7399.7 7403.7 7437.9 1970.5 2194.6 2244.4 2248.4 2274.2 2243.4 2250.7 2254.2 2254.3 2255.5 2103.0 2165.6 2168.1 2168.9 2170.7 2184.9 2197.0 2207.5 2218.3 2237.3 2190.6 2195.0 2196.5 2205.0 2209.2 7444.1 7507.5 7510.9 7523.2 7537.9 4466.8 4583.0 4591.8 4595.6 4595.8 2955.8 2962.6 3005.2 3012.8 3110.8 986.8 987.5 1007.0 1026.6 1044.5 10021.1 10166.1 10180.4 10186.3 10198.1 4031.4 4168.6 4196.1 4203.8 4215.2 8794.6 8864.6 8890.5 8895.6 8898.9 4064.0 4626.8 4631.8 4643.1 4648.2 3967.4 4042.0 4045.0 4077.6 4080.8 3400.7 3466.3 3489.2 3500.7 3547.8 1060.2 1091.7 1094.3 1095.2 1106.4 1296.6 1307.4 1320.0 1321.3 1341.7 7157.4 7158.4 7265.5 7280.7 7285.7 482.6 486.1 490.0 493.1 497.7 5421.7 5423.3 5428.2 5474.3 5476.4 8489.5 8679.7 8869.3 8877.6 8908.6 8744.3 8786.3 8813.5 8826.2 8841.5 6732.7 7034.3 7041.1 7045.6 7119.3 6960.7 6987.5 6994.9 7007.4 7040.5 7701.6 7941.4 7965.3 8121.8 8143.1 8018.0 8139.3 8277.2 8296.4 8335.6 5731.9 6210.8 6357.7 6447.4 6543.9 6772.9 6778.1 6803.6 6817.0 6817.6 6116.7 6325.2 6350.2 6418.5 6419.9 6297.1 6443.8 6445.2 6474.6 6564.3 6697.9 6719.1 6730.8 6741.8 6744.7 6088.6 6093.0 6101.5 6112.2 6158.8 6216.2 6332.2 6335.9 6351.5 6353.7 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | [#4] prototype.html Cycles:180 Average:5255.61 Median:5978.14 stddev:1616.53 (27.0%) stddev-sans-first:1577.97 06:12:29 INFO - PROCESS | 3332 | Values: 315.9 320.2 322.2 324.0 328.5 5894.1 5955.8 5961.9 5966.9 5989.3 5809.6 5833.6 5840.1 5841.4 5843.6 4318.0 4411.1 4517.0 4554.2 4563.1 4525.8 4540.6 4540.8 4543.0 4548.5 4468.7 4479.3 4520.8 4549.8 4552.0 4309.8 4330.2 4474.9 4497.5 4527.4 3879.9 3903.9 3924.4 3929.0 3932.1 5647.5 5674.1 5675.0 5681.2 5692.7 5228.6 5248.4 5251.6 5253.5 5255.1 6245.0 6246.7 6252.3 6260.2 6264.8 4134.5 4285.1 4395.7 4414.1 4420.8 6449.5 6523.2 6569.6 6600.2 6614.7 4367.4 4372.4 4373.3 4375.2 4380.2 4422.2 4428.2 4428.2 4430.5 4430.7 5153.2 5161.5 5168.4 5170.7 5172.8 6161.6 6302.3 6310.4 6316.7 6318.3 1524.8 1562.9 1565.0 1565.0 1565.2 940.0 956.3 962.3 996.2 1015.8 5840.4 5939.6 5952.0 5955.8 5964.7 6615.3 6618.8 6637.5 6651.0 6652.1 5992.3 5998.9 6002.3 6002.8 6007.0 3462.5 3517.1 3519.3 3521.5 3521.5 6527.6 6546.1 6623.6 6672.2 6804.4 6668.2 6699.1 6707.2 6713.9 6715.4 6798.3 6813.3 6821.8 6822.5 6828.8 6482.3 6531.4 6532.1 6533.8 6551.0 6237.4 6464.5 6474.9 6484.9 6497.5 6818.5 6845.8 6846.2 6859.6 6869.6 4295.5 4332.7 4348.3 4349.9 4354.0 6558.4 6563.4 6568.9 6569.2 6579.6 5928.5 6100.6 6374.3 6444.9 6461.7 6209.2 6320.8 6355.2 6366.3 6367.9 6243.0 6247.6 6248.8 6252.2 6255.7 6379.7 6402.4 6403.9 6405.2 6407.3 6094.8 6229.4 6242.8 6256.5 6256.9 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | [#5] yui.html Cycles:180 Average:13383.66 Median:4328.26 stddev:15104.85 (349.0%) stddev-sans-first:15117.38 06:12:29 INFO - PROCESS | 3332 | Values: 740.0 758.9 798.7 816.3 831.8 13868.7 14055.6 14062.7 14089.4 14093.1 14905.6 15056.3 15061.0 15080.5 15114.8 692.4 813.1 840.3 847.7 851.8 814.8 820.8 829.5 830.2 830.7 868.3 884.5 885.7 887.3 888.0 710.3 859.4 866.3 876.6 879.2 627.4 639.2 647.0 647.2 647.4 13962.6 13964.7 13980.4 14010.7 14036.6 12496.4 12637.2 12722.4 12977.4 12989.2 11038.6 11067.2 11129.6 11201.2 11301.8 3586.2 3609.6 3637.7 3749.7 3752.3 50218.0 50834.2 50864.2 53059.7 53310.2 10255.2 10269.3 10365.2 10457.3 11027.7 18392.6 18399.6 18441.5 18446.4 18496.5 7741.1 7837.3 7884.2 7887.0 7935.3 4212.0 4219.3 4298.7 4357.8 4444.6 3131.0 3143.0 3156.2 3165.2 3168.1 571.3 573.9 585.9 586.5 596.2 548.0 650.2 671.0 675.5 696.2 7475.7 7512.7 7516.7 8006.2 8116.6 489.1 603.0 654.7 658.7 676.4 3993.5 4016.6 4033.3 4195.6 4198.6 53631.0 54049.0 54480.5 54684.7 54787.5 45398.3 46260.5 46539.5 47160.3 47884.3 40698.2 40873.4 40881.0 41404.8 41887.0 8326.8 8551.6 8561.0 8578.8 8598.5 32524.3 32985.5 33220.2 33292.5 33412.5 37130.3 40489.8 41261.6 41671.2 42895.1 9610.8 9922.0 10099.9 10139.4 10270.4 11039.7 11271.0 11419.7 11453.5 11555.3 10744.7 11246.3 11258.7 11473.7 11507.0 10100.1 10266.5 10722.1 11105.0 11114.9 10519.2 11042.8 11305.9 11373.8 11379.0 8417.5 9577.3 9662.2 9667.3 9671.0 7930.3 8055.4 8700.2 9058.5 9366.9 06:12:29 INFO - PROCESS | 3332 | -------- Summary: end -------- 06:12:29 INFO - PROCESS | 3332 | 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:29 INFO - PROCESS | 3332 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:30 INFO - TEST-INFO | 3332: exit 0 06:12:30 INFO - TEST-OK | dromaeo_css | took 1111912ms 06:12:30 INFO - TEST-START | kraken 06:12:30 INFO - operating with platform_type : linux_ 06:12:30 INFO - Initialising browser for kraken test... 06:12:30 INFO - TEST-INFO | started process 3512 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAVcii9/profile http://localhost:49255/getInfo.html) 06:12:33 INFO - PROCESS | 3512 | __metrics Screen width/height:1600/1200 06:12:33 INFO - PROCESS | 3512 | colorDepth:24 06:12:33 INFO - PROCESS | 3512 | Browser inner width/height: 1024/697 06:12:33 INFO - PROCESS | 3512 | __metrics 06:12:34 INFO - PROCESS | 3512 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:34 INFO - PROCESS | 3512 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:12:35 INFO - TEST-INFO | 3512: exit 0 06:12:35 INFO - Browser initialized. 06:12:35 INFO - Running cycle 1/1 for kraken test... 06:12:35 INFO - TEST-INFO | started process 3597 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAVcii9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:47 INFO - PROCESS | 3597 | RSS: Main: 150577152 06:12:47 INFO - PROCESS | 3597 | 06:12:49 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49255/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:50 INFO - PROCESS | 3597 | RSS: Main: 195620864 06:12:50 INFO - PROCESS | 3597 | 06:12:52 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49255/tests/kraken/driver.html?testName=audio-dft) 06:12:53 INFO - PROCESS | 3597 | RSS: Main: 185315328 06:12:53 INFO - PROCESS | 3597 | 06:12:56 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49255/tests/kraken/driver.html?testName=audio-fft) 06:12:57 INFO - PROCESS | 3597 | RSS: Main: 168628224 06:12:57 INFO - PROCESS | 3597 | 06:12:59 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49255/tests/kraken/driver.html?testName=audio-oscillator) 06:12:59 INFO - PROCESS | 3597 | RSS: Main: 170033152 06:12:59 INFO - PROCESS | 3597 | 06:13:01 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49255/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:02 INFO - PROCESS | 3597 | RSS: Main: 171122688 06:13:02 INFO - PROCESS | 3597 | 06:13:05 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49255/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:05 INFO - PROCESS | 3597 | RSS: Main: 172404736 06:13:05 INFO - PROCESS | 3597 | 06:13:09 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49255/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:09 INFO - PROCESS | 3597 | RSS: Main: 173191168 06:13:09 INFO - PROCESS | 3597 | 06:13:12 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49255/tests/kraken/driver.html?testName=json-parse-financial) 06:13:13 INFO - PROCESS | 3597 | RSS: Main: 172515328 06:13:13 INFO - PROCESS | 3597 | 06:13:14 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49255/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:15 INFO - PROCESS | 3597 | RSS: Main: 184963072 06:13:15 INFO - PROCESS | 3597 | 06:13:17 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:17 INFO - PROCESS | 3597 | RSS: Main: 181526528 06:13:17 INFO - PROCESS | 3597 | 06:13:19 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:20 INFO - PROCESS | 3597 | RSS: Main: 189071360 06:13:20 INFO - PROCESS | 3597 | 06:13:22 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:23 INFO - PROCESS | 3597 | RSS: Main: 195928064 06:13:23 INFO - PROCESS | 3597 | 06:13:25 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:26 INFO - PROCESS | 3597 | RSS: Main: 197554176 06:13:26 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | Cycle 1(1): loaded http://localhost:49255/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49255/tests/kraken/driver.html?testName=ai-astar) 06:13:28 INFO - PROCESS | 3597 | RSS: Main: 257847296 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | __start_tp_report 06:13:28 INFO - PROCESS | 3597 | _x_x_mozilla_page_load 06:13:28 INFO - PROCESS | 3597 | _x_x_mozilla_page_load_details 06:13:28 INFO - PROCESS | 3597 | |i|pagename|runs| 06:13:28 INFO - PROCESS | 3597 | |0;ai-astar;112;114;108;111;113;113;101;113;112;112 06:13:28 INFO - PROCESS | 3597 | |1;audio-beat-detection;151;134;157;161;130;153;156;142;175;130 06:13:28 INFO - PROCESS | 3597 | |2;audio-dft;160;162;161;162;160;161;160;165;162;164 06:13:28 INFO - PROCESS | 3597 | |3;audio-fft;73;73;95;93;72;73;73;108;100;72 06:13:28 INFO - PROCESS | 3597 | |4;audio-oscillator;96;95;151;96;95;95;148;95;96;151 06:13:28 INFO - PROCESS | 3597 | |5;imaging-gaussian-blur;119;116;115;115;114;115;115;115;115;115 06:13:28 INFO - PROCESS | 3597 | |6;imaging-darkroom;146;146;145;147;146;147;145;147;145;145 06:13:28 INFO - PROCESS | 3597 | |7;imaging-desaturate;96;96;95;96;96;97;96;96;97;96 06:13:28 INFO - PROCESS | 3597 | |8;json-parse-financial;56;57;57;55;57;55;57;66;55;53 06:13:28 INFO - PROCESS | 3597 | |9;json-stringify-tinderbox;67;68;67;67;68;67;68;67;68;67 06:13:28 INFO - PROCESS | 3597 | |10;stanford-crypto-aes;81;81;82;82;82;82;83;82;82;82 06:13:28 INFO - PROCESS | 3597 | |11;stanford-crypto-ccm;123;123;122;114;116;115;123;126;117;115 06:13:28 INFO - PROCESS | 3597 | |12;stanford-crypto-pbkdf2;154;139;150;149;151;138;147;147;147;150 06:13:28 INFO - PROCESS | 3597 | |13;stanford-crypto-sha256-iterative;70;69;70;68;75;71;70;73;68;68 06:13:28 INFO - PROCESS | 3597 | __end_tp_report 06:13:28 INFO - PROCESS | 3597 | __start_cc_report 06:13:28 INFO - PROCESS | 3597 | _x_x_mozilla_cycle_collect,1074 06:13:28 INFO - PROCESS | 3597 | __end_cc_report 06:13:28 INFO - PROCESS | 3597 | __startTimestamp1456582408487__endTimestamp 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | ------- Summary: start ------- 06:13:28 INFO - PROCESS | 3597 | Number of tests: 14 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.84 (3.4%) stddev-sans-first:4.06 06:13:28 INFO - PROCESS | 3597 | Values: 112.0 114.0 108.0 111.0 113.0 113.0 101.0 113.0 112.0 112.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.50 stddev:14.72 (9.5%) stddev-sans-first:15.59 06:13:28 INFO - PROCESS | 3597 | Values: 151.0 134.0 157.0 161.0 130.0 153.0 156.0 142.0 175.0 130.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.70 (1.1%) stddev-sans-first:1.69 06:13:28 INFO - PROCESS | 3597 | Values: 160.0 162.0 161.0 162.0 160.0 161.0 160.0 165.0 162.0 164.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#3] audio-fft Cycles:10 Average:83.20 Median:73.00 stddev:14.14 (19.4%) stddev-sans-first:14.51 06:13:28 INFO - PROCESS | 3597 | Values: 73.0 73.0 95.0 93.0 72.0 73.0 73.0 108.0 100.0 72.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:95.00 stddev:26.38 (27.8%) stddev-sans-first:27.35 06:13:28 INFO - PROCESS | 3597 | Values: 96.0 95.0 151.0 96.0 95.0 95.0 148.0 95.0 96.0 151.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 06:13:28 INFO - PROCESS | 3597 | Values: 119.0 116.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 06:13:28 INFO - PROCESS | 3597 | Values: 146.0 146.0 145.0 147.0 146.0 147.0 145.0 147.0 145.0 145.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:13:28 INFO - PROCESS | 3597 | Values: 96.0 96.0 95.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:3.49 (6.1%) stddev-sans-first:3.69 06:13:28 INFO - PROCESS | 3597 | Values: 56.0 57.0 57.0 55.0 57.0 55.0 57.0 66.0 55.0 53.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:13:28 INFO - PROCESS | 3597 | Values: 67.0 68.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 67.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 06:13:28 INFO - PROCESS | 3597 | Values: 81.0 81.0 82.0 82.0 82.0 82.0 83.0 82.0 82.0 82.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:122.50 stddev:4.40 (3.6%) stddev-sans-first:4.47 06:13:28 INFO - PROCESS | 3597 | Values: 123.0 123.0 122.0 114.0 116.0 115.0 123.0 126.0 117.0 115.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:149.50 stddev:5.07 (3.4%) stddev-sans-first:4.75 06:13:28 INFO - PROCESS | 3597 | Values: 154.0 139.0 150.0 149.0 151.0 138.0 147.0 147.0 147.0 150.0 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:2.30 (3.3%) stddev-sans-first:2.44 06:13:28 INFO - PROCESS | 3597 | Values: 70.0 69.0 70.0 68.0 75.0 71.0 70.0 73.0 68.0 68.0 06:13:28 INFO - PROCESS | 3597 | -------- Summary: end -------- 06:13:28 INFO - PROCESS | 3597 | 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:28 INFO - PROCESS | 3597 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 06:13:29 INFO - TEST-INFO | 3597: exit 0 06:13:29 INFO - TEST-OK | kraken | took 59362ms 06:13:29 INFO - SUITE-END | took 1171s 06:13:29 INFO - Completed test suite (00:19:31) 06:13:29 INFO - Working with test: dromaeo_css 06:13:29 INFO - Generating results file: dromaeo_css 06:13:29 INFO - Working with test: kraken 06:13:29 INFO - Generating results file: kraken 06:13:29 INFO - javascript benchmark 06:13:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:13:30 INFO - process_Request line: dromaeo_css 6834.17 graph.html#tests=[[72,1,35]] 06:13:30 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:30 INFO - process_Request line: kraken 1516.80 graph.html#tests=[[232,1,35]] 06:13:30 INFO - RETURN: dromaeo_css: 6834.17 06:13:30 INFO - RETURN: kraken: 1516.80 06:13:30 INFO - javascript benchmark 06:13:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3057.4038062577797, 3077.73839223666, 3114.0, 3122.344307695384, 3140.7487401007916, 4895.339129217555, 4902.534259245375, 4932.926006109911, 4984.352034235553, 5043.84868453947, 4999.575036121934, 5007.899842003158, 5062.873428164297, 5063.569596584295, 5071.74641267936, 4506.481754598214, 4587.472440669324, 4647.976760116195, 4660.0, 4687.953120468803, 4533.909321813562, 4717.882052948687, 4725.291206319062, 4737.478877323491, 4800.927986080212, 4524.3213517972235, 4553.2942393929, 4581.0, 4602.033572949685, 4626.9074618507775, 4594.058218065288, 4596.701214421052, 4605.677602567822, 4621.8151273949, 4656.231721765905, 4506.909861802746, 4561.2245918193985, 4578.725276483422, 4583.495815460296, 4590.0, 4815.0, 4820.469748327681, 4847.418309802811, 4856.2958371036, 4874.926876096862, 5289.1008528549855, 5289.338832645919, 5291.497307755757, 5304.177852432879, 5336.59975501835, 5322.680639161663, 5327.46725327468, 5333.0, 5397.0, 5464.9180262296095, 5055.59555235584, 5074.0, 5078.949210507884, 5082.059818933472, 5086.262491938648, 5464.043792336325, 5490.945090549123, 5495.835124946258, 5498.532624726943, 5499.312585926759, 5280.102382594968, 5289.68261904287, 5341.118715411992, 5363.624546281723, 5386.8383948481605, 5362.034833729888, 5382.3541175059245, 5390.191471279261, 5393.83818485446, 5400.729963501809, 5350.411454739976, 5356.705381204071, 5358.812441564526, 5362.115250983544, 5407.837764866981, 5291.206319052096, 5363.30277063987, 5386.865328366822, 5399.811006614749, 5458.099413596791, 4185.058361868555, 4185.539590645027, 4186.434831297735, 4201.894952626148, 4230.344296634026, 3738.43923411485, 3791.1659434924272, 3792.469054332396, 3815.08437974884, 3857.96142038576, 4936.432310284292, 4949.950500495021, 4965.90068198634, 4999.475055119233, 5012.022655582199, 5266.3943646480375, 5290.470952904756, 5294.788208471695, 5299.49654782795, 5319.521243088141, 4839.68542044773, 4914.606831453475, 4916.754162291871, 4920.237363208708, 4922.1140194765285, 4612.339557759204, 4619.284010978304, 4631.0506346198945, 4635.212013957568, 4673.60274376675, 5550.250716153268, 5551.417101204396, 5551.611387202857, 5552.056150454432, 5593.608447408642, 5242.030224408497, 5253.474652534716, 5329.54698850602, 5389.164679474688, 5395.406505284337, 5578.246936663499, 5601.6358936668985, 5604.411536788742, 5605.719714014202, 5636.689982051026, 5373.408925018323, 5374.7312634367345, 5380.381256155436, 5384.811531596375, 5437.184422336682, 5299.258103865539, 5315.04329220744, 5369.979703856255, 5409.540189083972, 5453.972730136324, 5239.0, 5245.527902488794, 5268.473152684701, 5274.340707411574, 5276.445973172762, 5261.684298941923, 5264.657797243167, 5269.077911365573, 5276.076686579757, 5318.494742999409, 5073.162928116967, 5092.337996060489, 5120.4111527174855, 5124.641275110706, 5168.457311982338, 5257.89484210306, 5267.868303292448, 5268.6575372600655, 5283.1546952487415, 5302.337207849019, 5003.474635163256, 5184.844454666366, 5198.584113271005, 5199.740012999259, 5245.213218017176], "unit": "score", "name": "dojo.html", "value": 4963.788086020074}, {"lowerIsBetter": false, "replicates": [525.3616855520544, 525.5874138801042, 564.3284491455169, 587.239524815364, 587.9088741245107, 27993.300167495796, 35221.2955740885, 35584.33117516184, 35765.642343576554, 35831.104222394424, 37922.9142397168, 38509.0, 38535.0, 38567.22865542687, 38584.22831543368, 7379.151397589266, 8361.372897032716, 8652.8702069469, 10034.397936123856, 10227.335223210468, 9987.75030624233, 10142.087212150906, 10156.085952264295, 10158.0, 10164.84752728706, 10199.490025498695, 10285.280030397875, 10304.845427318596, 10307.948460257689, 10309.48452577372, 10115.645952391667, 10192.184625229964, 10204.642837500653, 10205.081542661159, 10209.489525523693, 10413.843792343121, 10579.471026448648, 10582.100521455686, 10590.0, 10594.046535811814, 40124.799376002935, 40761.59238407637, 40768.18463630741, 40768.38847417291, 40774.388384174265, 3366.5960084789735, 3393.053598896863, 3897.883063508071, 4085.5097388313297, 4101.405296232059, 30259.546106808415, 30672.233194170323, 30920.845395773104, 30938.0, 32443.51334729981, 3826.4260360945805, 3882.747621404628, 3992.1017771001584, 4000.5599384067727, 4051.2181932737626, 281888.0, 283119.0, 283844.0, 284012.0, 284440.9999999979, 55967.720161399746, 56086.15870761942, 56672.43327566754, 56808.71595642078, 56854.43145568574, 61557.384426155164, 61782.38217617856, 61935.69032154811, 62118.68940655268, 62120.68939655273, 13348.73302533944, 15156.24218789056, 15215.08709477435, 15509.689806203813, 15524.767128493082, 10512.42181680015, 10534.525946332433, 10559.736006599896, 10565.418901960466, 10586.735331616617, 18398.448046558624, 18571.907140464482, 18579.349722759638, 18594.81405185958, 18618.53453663642, 6588.4729221662155, 7623.69505219785, 7737.690492380242, 7853.842923141505, 8045.436819422584, 890.643742503004, 938.8591711243369, 979.7697541077841, 994.2841154368842, 1109.2623405435295, 27835.0, 27914.441711165662, 28207.43585128286, 28254.71745282562, 28582.14253572396, 1025.7538190834146, 1061.7982583309147, 1097.9121670266359, 1106.2035334559105, 1136.0570726297153, 14249.145051296955, 14473.78289325661, 14603.0, 14633.609807068311, 14693.485727999469, 306860.0, 309670.0, 312980.0, 313702.0, 315834.0, 50926.23610645843, 51128.0, 51147.232791508155, 51210.74394628003, 51256.743716281926, 1247.5446462041289, 1270.2822905058797, 1312.2389014371643, 1363.1344096498597, 1379.7102608452137, 24414.51170976535, 25515.234542963743, 25821.870890645427, 25938.61092083658, 25965.480690386463, 37910.0, 37973.62026379811, 38297.61702382941, 38297.61702383052, 38327.42508862425, 182499.0, 184259.0, 194532.0, 197387.0, 197728.0, 26475.60286595741, 30497.0, 30865.228369290948, 30897.53653695241, 31152.065438036894, 35932.28135437329, 36673.26653466969, 36919.44620830636, 36972.44541331936, 37427.81286093661, 32927.341453171284, 33903.830480847435, 34048.319033618696, 34075.65924340725, 35007.47488787619, 33848.830755846066, 34175.487367689006, 34561.48157777686, 34722.826385867906, 34730.82634586912, 34044.0, 34695.65304346924, 34924.0, 35092.12269693278, 35209.647903520636, 29853.55219671663, 31000.0, 31198.532022019233, 31531.211719706273, 31584.684153158174, 23337.416564585343, 24029.0, 24036.63631812952, 24122.0, 24154.0], "unit": "score", "name": "ext.html", "value": 18052.30570385335}, {"lowerIsBetter": false, "replicates": [345.77524609004155, 348.99127521811965, 349.90902365384994, 350.23124242288173, 357.53877498027543, 16476.588085297873, 17072.402465913696, 17605.471835844914, 18263.81736182638, 18320.35878744244, 10350.637727679532, 10368.48157592121, 10377.0, 10736.78526429473, 10877.564897404114, 4745.833895813638, 4962.776675049613, 4975.8258460953875, 4982.725950072744, 4999.625028122887, 3650.653187947141, 5749.878773639142, 6689.832754181136, 6932.23745388007, 6937.479689023344, 6895.862082758342, 6899.310068993111, 6903.482238832083, 6915.965420172917, 6927.861442771142, 6308.116863639094, 6566.113574667406, 6571.7371305147735, 6592.044153597725, 6604.636744979024, 4135.152293779768, 6266.154069200645, 6509.967450162719, 6513.772017979395, 6524.184476940382, 20701.27545535914, 21274.787252127437, 22411.103555857746, 22482.213122540634, 22520.54958900813, 2390.6414037894283, 2407.518496300747, 2408.638704194367, 2514.962275565868, 2746.5056289867816, 12987.610371688865, 13205.0, 13273.402696878664, 13486.527971521047, 13872.4451021959, 1998.8043045037894, 2060.536379314657, 2064.1021155797275, 2073.232903825579, 2091.895405229732, 66231.0, 71775.0, 72179.63910180469, 72250.63874680645, 74761.25238747598, 14658.633534161518, 14982.576655217737, 15554.377824887104, 15555.144467054195, 15570.766438503431, 24219.636705449433, 24329.878350608134, 24387.26838194857, 24422.51154976926, 24505.87747061289, 8847.73456796297, 8864.379493435526, 9130.406523575946, 9143.131402516883, 9246.583903724348, 7766.068071831416, 7798.298153166243, 7930.762077137695, 7944.245296696805, 7963.362930965509, 7696.11494678108, 7853.253940875607, 7857.2928436441, 7861.584914715292, 7901.012373453318, 2927.6779554249015, 3054.7250747432836, 3064.8161110333454, 3169.9683003170135, 3174.6031746031745, 847.8007668197969, 940.7507010642186, 952.1620973543238, 965.99034009659, 1060.8726952765717, 16173.110478923536, 16507.174641267888, 16736.330546778237, 16739.246733897005, 17103.0, 916.8212198621205, 933.290699068699, 965.6185806606351, 966.1787480641539, 984.684900831727, 9266.44401335922, 9493.0981556752, 9516.23870090391, 9528.666496672584, 9775.657851975147, 415764.0, 417170.0, 421747.0, 424478.0, 426715.0, 45214.0, 67442.32557674458, 70816.0, 71526.0, 72910.0, 1049.8845127036172, 1063.1494804156644, 1067.4502631144967, 1107.894749998749, 1108.4679353910008, 15103.622409439851, 15212.46756363522, 15262.015937927998, 15540.378384864478, 15753.527394178192, 32879.178020549676, 33211.66788332086, 33424.158946488846, 34961.30077398488, 34965.0, 46178.53821461742, 47342.52657473381, 47425.52574474211, 48316.7584162091, 48992.75503622459, 7787.104482984303, 7828.608569571385, 7850.960745196237, 7933.246341597539, 7982.321502672338, 11512.884871151517, 11997.580084696994, 12279.877201228232, 12630.179038362478, 12955.676108096995, 10536.420496872439, 10766.246362754846, 10851.565937362417, 10993.0, 11073.905764171226, 10544.736381590521, 10694.786104278026, 10886.29239099456, 10943.507542160782, 11021.393823339793, 10861.837072443761, 10948.288361256493, 11027.952344527257, 11141.713194607772, 11231.494582743959, 7532.510386824839, 7599.734009309647, 7826.295633393022, 7836.451448398558, 7843.294103530709, 8270.007599088149, 10677.359358438518, 10693.786124277316, 10920.2901811382, 11148.832767508657], "unit": "score", "name": "jquery.html", "value": 9132.33135729281}, {"lowerIsBetter": false, "replicates": [1348.4673553946186, 1455.8616931391518, 1466.1789397937152, 1591.9363225470981, 1743.1894169211323, 7262.310080542353, 7372.0, 7391.0761154855645, 7406.259374062591, 7408.148062972759, 7251.129864416277, 7361.742339018136, 7399.741009064684, 7403.740869069584, 7437.888431673529, 1970.5172232802984, 2194.5940001099766, 2244.394013616323, 2248.4491299631613, 2274.192661605131, 2243.4167116549734, 2250.6849041134255, 2254.199759085526, 2254.289898681918, 2255.458689914417, 2102.9684554731693, 2165.577712346093, 2168.1327469012363, 2168.8807115608633, 2170.663547150194, 2184.9016794244376, 2197.0, 2207.5253820428607, 2218.3455880515126, 2237.2505210754416, 2190.6166420876443, 2195.0232146694725, 2196.516766311409, 2204.9857065749775, 2209.193644319828, 7444.143923448819, 7507.512011719221, 7510.924890751132, 7523.247675232487, 7537.886931696029, 4466.82132714691, 4583.0, 4591.816327346902, 4595.586397224232, 4595.8391456299205, 2955.807872488303, 2962.614860068177, 3005.1735772662473, 3012.8493575321368, 3110.782245242834, 986.8421052631544, 987.456898705709, 1006.9748256293651, 1026.5688410867378, 1044.5456226541403, 10021.098101170857, 10166.135878450266, 10180.389176649425, 10186.28695991281, 10198.082172604501, 4031.3549832026733, 4168.583141685807, 4196.097838964637, 4203.810828512725, 4215.156968606291, 8794.560271986375, 8864.601092950703, 8890.4665720057, 8895.644174233088, 8898.86651700225, 4064.04494943688, 4626.83806066786, 4631.8378856739855, 4643.071385722869, 4648.209804333272, 3967.3850553164307, 4042.0299128209017, 4045.0494133878515, 4077.5922407758985, 4080.81636326366, 3400.7449441292, 3466.2894106708063, 3489.2498112905846, 3500.7374446916074, 3547.840347184383, 1060.2313322841032, 1091.737982884118, 1094.2996482251365, 1095.1786160379716, 1106.4136007915818, 1296.6304603188235, 1307.4247331174254, 1319.9868001319865, 1321.3393303348325, 1341.6511706956067, 7157.391621712109, 7158.391536719333, 7265.455090868206, 7280.745173918994, 7285.672144753499, 482.6476672029368, 486.10799183498676, 489.96570240082855, 493.1247036510151, 497.72376331136564, 5421.674699518042, 5423.294971653739, 5428.212909128154, 5474.315710536183, 5476.397596264408, 8489.490630562186, 8679.696210632725, 8869.290456763443, 8877.600507977157, 8908.599113039929, 8744.300455963508, 8786.341024423195, 8813.515256660945, 8826.249768769727, 8841.469511829311, 6732.730690772412, 7034.261402552658, 7041.119860017498, 7045.577265364094, 7119.252478489788, 6960.721571137098, 6987.510874238755, 6994.860102798018, 7007.369336759716, 7040.542364746275, 7701.576413297323, 7941.444098913252, 7965.322947549524, 8121.75634730959, 8143.144969778325, 8017.959910200411, 8139.308158806568, 8277.172282771675, 8296.419250652638, 8335.583220839055, 5731.885362292647, 6210.782622608187, 6357.745690172342, 6447.3552644735155, 6543.934560654333, 6772.93227067723, 6778.118844550177, 6803.557768745016, 6817.0, 6817.5568588041615, 6116.724747386467, 6325.177726895474, 6350.206224221973, 6418.4865210783955, 6419.903701444388, 6297.055441683784, 6443.806685799434, 6445.1943507061615, 6474.611523308617, 6564.310747371457, 6697.899531506934, 6719.059331693469, 6730.798076057726, 6741.764038258638, 6744.730210791709, 6088.634681919099, 6093.025115981422, 6101.450869421773, 6112.205413296243, 6158.846028849135, 6216.191895053614, 6332.176817013758, 6335.936640633719, 6351.460125889351, 6353.650549219652], "unit": "score", "name": "mootools.html", "value": 4221.113746324585}, {"lowerIsBetter": false, "replicates": [315.9352332771782, 320.16117771438826, 322.2154054876376, 324.0473009352505, 328.50887922555785, 5894.0864166054225, 5955.791547295846, 5961.910571341428, 5966.940330596693, 5989.341172471025, 5809.622374545652, 5833.620814647045, 5840.0947853082735, 5841.386654401291, 5843.590948633598, 4318.0, 4411.05162390086, 4516.954830451703, 4554.225781617133, 4563.133004729108, 4525.818967241306, 4540.614047805941, 4540.7502587357685, 4542.954570454286, 4548.5224051474615, 4468.709533880287, 4479.283314669654, 4520.796564154621, 4549.795259213327, 4551.953050798318, 4309.849155279566, 4330.17726631939, 4474.932876006863, 4497.482789479219, 4527.366168736379, 3879.8836034919, 3903.882883513499, 3924.4309575111733, 3929.0, 3932.1152740633415, 5647.548196144298, 5674.09214525678, 5675.006873797069, 5681.176229446748, 5692.743826527816, 5228.5817134629515, 5248.422673505911, 5251.55361794248, 5253.52718255355, 5255.1329030709885, 6245.0, 6246.6876656167005, 6252.2809876864285, 6260.217472815898, 6264.7807326743805, 4134.545200027995, 4285.0572873967985, 4395.7142785718825, 4414.05097903949, 4420.80106395213, 6449.516286278501, 6523.18460192476, 6569.638669873155, 6600.207975043026, 6614.669266536654, 4367.388565600819, 4372.3878656988045, 4373.2565463871215, 4375.190589740908, 4380.211561918885, 4422.181896349121, 4428.180786554498, 4428.247197976288, 4430.5126436092005, 4430.667699922518, 5153.2270159476375, 5161.458046905096, 5168.431472538018, 5170.663906846118, 5172.844814655567, 6161.568690191643, 6302.275238347649, 6310.400511951358, 6316.684165791692, 6318.336574659686, 1524.7636616324487, 1562.8515291047331, 1564.9765253521207, 1565.0218613366646, 1565.1626379886707, 939.9577019034023, 956.3257903178243, 962.3023308101571, 996.1532697207316, 1015.8425444056184, 5840.415958404211, 5939.554533410012, 5952.0179170436395, 5955.7617695292565, 5964.7315870785915, 6615.338466153443, 6618.768343107968, 6637.502187335969, 6650.9667451662435, 6652.135222421054, 5992.280926288786, 5998.850028749229, 6002.279726432768, 6002.789902353396, 6006.978813601698, 3462.480627905784, 3517.138301116243, 3519.3137338218803, 3521.454174602941, 3521.454174602941, 6527.5757075789925, 6546.083548303146, 6623.602583844985, 6672.232693240242, 6804.4216241620015, 6668.233153187349, 6699.062131301622, 6707.1616047994, 6713.865722685519, 6715.395614394728, 6798.320167983162, 6813.250542440328, 6821.761238356634, 6822.454203663596, 6828.760993365208, 6482.319356467503, 6531.444827189552, 6532.05285233629, 6533.803985880431, 6551.0, 6237.407446292595, 6464.515161362822, 6474.902876456763, 6484.870302594016, 6497.512686548623, 6818.454523638196, 6845.760398386033, 6846.246912839683, 6859.622720750406, 6869.553479023847, 4295.463067116611, 4332.740035597874, 4348.326009468537, 4349.934750978675, 4354.042110735633, 6558.376954189344, 6563.442107420923, 6568.868622627616, 6569.178852643419, 6579.572327798678, 5928.4960778334325, 6100.572959892765, 6374.3306952771145, 6444.871102578016, 6461.741530338922, 6209.161763161916, 6320.841978950563, 6355.205599300088, 6366.331535188924, 6367.87264254703, 6243.0, 6247.562670613013, 6248.812535623939, 6252.187215661935, 6255.687215639109, 6379.7129129190225, 6402.391772781578, 6403.903941440789, 6405.167328247298, 6407.295197528361, 6094.8171554853425, 6229.4393504584805, 6242.750289988349, 6256.499480041494, 6256.937430625636], "unit": "score", "name": "prototype.html", "value": 4719.140629547485}, {"lowerIsBetter": false, "replicates": [739.9778006659799, 758.8558173946954, 798.7404093669555, 816.2775943290187, 831.8128421105253, 13868.653283667913, 14055.578332650037, 14062.718745625081, 14089.365978530965, 14093.083949543272, 14905.552833415015, 15056.322465489053, 15061.0, 15080.547583572483, 15114.773278400833, 692.4460431654682, 813.1461964936822, 840.2815592668258, 847.7329641163014, 851.8040850604365, 814.767791179514, 820.8358328334327, 829.4567058576642, 830.1822704635929, 830.7466222802043, 868.3010176807667, 884.4914174349775, 885.6988623867884, 887.2635712358759, 887.9600417981206, 710.3322876496103, 859.3898332184157, 866.3285953386113, 876.6361959786681, 879.1647934462286, 627.3882964110002, 639.1978067525226, 647.0294558162756, 647.2233320015999, 647.4367300448592, 13962.58112256634, 13964.650883727887, 13980.440782368692, 14010.719785604231, 14036.649083772885, 12496.437660305308, 12637.2417654941, 12722.363881805873, 12977.35113244334, 12989.220646761225, 11038.613648522343, 11067.225294229407, 11129.610463633815, 11201.159913006475, 11301.773964520746, 3586.1891035023486, 3609.6029436761937, 3637.654422829827, 3749.737518373715, 3752.2683076800035, 50218.0, 50834.237486437734, 50864.23703644448, 53059.73470132663, 53310.20034699521, 10255.212113378982, 10269.332493388056, 10365.170786337076, 10457.26799124054, 11027.669169924915, 18392.632147356977, 18399.632007359778, 18441.53896152607, 18446.35437759672, 18496.537586560175, 7741.07107147146, 7837.294643482114, 7884.17216192303, 7887.0, 7935.325497332791, 4211.957880421218, 4219.346001369731, 4298.677599180074, 4357.8451710296795, 4444.5777651123735, 3130.98434507826, 3143.0413723814454, 3156.179393357698, 3165.208697825544, 3168.0970923287214, 571.3087164530881, 573.8852229554105, 585.8916100521417, 586.4809643465478, 596.1683451585014, 547.9589030822705, 650.2067477677226, 670.9765158219438, 675.5035049238805, 696.1993707236718, 7475.663595138232, 7512.699492020258, 7516.699332026657, 8006.15935326794, 8116.6347514362, 489.1000558971509, 602.9553723917672, 654.7348323928817, 658.6937074260492, 676.3844901139939, 3993.5008123984503, 4016.6184212499766, 4033.253848038122, 4195.643370313557, 4198.624965226765, 53631.0, 54049.0, 54480.45519544754, 54684.72657636686, 54787.45212547903, 45398.319025214645, 46260.5373946263, 46539.534604654196, 47160.29259561041, 47884.28173577399, 40698.18603627911, 40873.386899196536, 40881.0, 41404.79297603493, 41887.0, 8326.79183020405, 8551.57242137903, 8561.0, 8578.768146245326, 8598.484090954562, 32524.349513010082, 32985.50521742224, 33220.1694957628, 33292.469002910104, 33412.498812518315, 37130.257394852495, 40489.79755101206, 41261.58738412578, 41671.166576668904, 42895.1420971585, 9610.807783844144, 9922.0, 10099.899001009895, 10139.442330671884, 10270.43512606784, 11039.668809935714, 11271.0, 11419.714507137389, 11453.484593193492, 11555.306681599131, 10744.677659670222, 11246.268992515461, 11258.66224013281, 11473.655790326304, 11507.0, 10100.141487973604, 10266.486675666038, 10722.142228621535, 11105.0, 11114.944425277821, 10519.211059170746, 11042.834357484484, 11305.886941130813, 11373.772524549628, 11379.0, 8417.537035463109, 9577.281703872099, 9662.17871480932, 9667.274954378308, 9670.951645241728, 7930.325922296439, 8055.395845311742, 8700.173483519056, 9058.547072646474, 9366.906330936603], "unit": "score", "name": "yui.html", "value": 6249.61928141161}], "name": "dromaeo_css", "value": 6834.166479443306}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 111.0, 113.0, 113.0, 101.0, 113.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [151.0, 134.0, 157.0, 161.0, 130.0, 153.0, 156.0, 142.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 162.0, 160.0, 161.0, 160.0, 165.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 95.0, 93.0, 72.0, 73.0, 73.0, 108.0, 100.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 151.0, 96.0, 95.0, 95.0, 148.0, 95.0, 96.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 111.8}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 147.0, 145.0, 147.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 55.0, 57.0, 55.0, 57.0, 66.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 122.0, 114.0, 116.0, 115.0, 123.0, 126.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [154.0, 139.0, 150.0, 149.0, 151.0, 138.0, 147.0, 147.0, 147.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 68.0, 75.0, 71.0, 70.0, 73.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1516.8000000000004}]} 06:13:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1516.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6834.17"}}} 06:13:30 INFO - Return code: 0 06:13:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:13:30 INFO - # TBPL SUCCESS # 06:13:30 INFO - Running post-action listener: _resource_record_post_action 06:13:30 INFO - Running post-run listener: _resource_record_post_run 06:13:31 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 541597696; Read time: 0; Write time: 392140 06:13:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247373824; Read time: 0; Write time: 240012 06:13:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 294223872; Read time: 0; Write time: 152128 06:13:31 INFO - Running post-run listener: _upload_blobber_files 06:13:31 INFO - Blob upload gear active. 06:13:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:13:31 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:13:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:13:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:13:31 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:32 INFO - (blobuploader) - INFO - Done attempting. 06:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:33 INFO - (blobuploader) - INFO - Done attempting. 06:13:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:33 INFO - Return code: 0 06:13:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:13:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd74765a2259d32ca7a38a953bf42f60917ca5a9b6f62368119c9fa6f874fbdeec70eeebdfbe503dccbf89bd493d14c3d51505618f5d61b255635b7bd16442b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dda2b4a653a4cd537056be4e0805b8eb65ffe797720255e443d440f975db76e88738213732f625a3a522243a989131340a27a4f66a4fb95a9f03233aefd5c2"} 06:13:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:13:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:13:33 INFO - Contents: 06:13:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd74765a2259d32ca7a38a953bf42f60917ca5a9b6f62368119c9fa6f874fbdeec70eeebdfbe503dccbf89bd493d14c3d51505618f5d61b255635b7bd16442b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dda2b4a653a4cd537056be4e0805b8eb65ffe797720255e443d440f975db76e88738213732f625a3a522243a989131340a27a4f66a4fb95a9f03233aefd5c2"} 06:13:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:33 INFO - Copying logs to upload dir... 06:13:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:13:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.446008 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-02-27 06:13:32.755615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 06:13:32.759152) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd74765a2259d32ca7a38a953bf42f60917ca5a9b6f62368119c9fa6f874fbdeec70eeebdfbe503dccbf89bd493d14c3d51505618f5d61b255635b7bd16442b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dda2b4a653a4cd537056be4e0805b8eb65ffe797720255e443d440f975db76e88738213732f625a3a522243a989131340a27a4f66a4fb95a9f03233aefd5c2"} build_url:https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/Km6sU_8dTs-TGUkwA9-yfQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd74765a2259d32ca7a38a953bf42f60917ca5a9b6f62368119c9fa6f874fbdeec70eeebdfbe503dccbf89bd493d14c3d51505618f5d61b255635b7bd16442b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dda2b4a653a4cd537056be4e0805b8eb65ffe797720255e443d440f975db76e88738213732f625a3a522243a989131340a27a4f66a4fb95a9f03233aefd5c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 06:13:32.784506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 06:13:32.784914) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456581185.150185-122262365 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 06:13:32.866731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 06:13:32.867103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 06:13:32.867447) ========= ========= Total master_lag: 0.29 =========