builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1460010551.45 results: success (0) buildid: 20160406210052 builduid: d02798328d1b4be6b41fa4e326b9d388 revision: 807dc77c648fe2c8ed29e86b2d4c033756db178f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.452721) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.453097) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.453380) ========= 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006501 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.487598) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.487886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.519999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.520262) ========= 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.588486) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.588764) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.589103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:11.589370) ========= 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 23:29:12-- 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% 226M=0s 2016-04-06 23:29:12 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.386560 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.041081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.041353) ========= 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017697 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.072910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.073217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 807dc77c648fe2c8ed29e86b2d4c033756db178f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 807dc77c648fe2c8ed29e86b2d4c033756db178f --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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 23:29:13,104 truncating revision to first 12 chars 2016-04-06 23:29:13,104 Setting DEBUG logging. 2016-04-06 23:29:13,104 attempt 1/10 2016-04-06 23:29:13,104 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/807dc77c648f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 23:29:13,376 unpacking tar archive at: mozilla-beta-807dc77c648f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565147 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.653322) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.653649) ========= echo 807dc77c648fe2c8ed29e86b2d4c033756db178f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'807dc77c648fe2c8ed29e86b2d4c033756db178f'] 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 807dc77c648fe2c8ed29e86b2d4c033756db178f program finished with exit code 0 elapsedTime=0.004623 script_repo_revision: '807dc77c648fe2c8ed29e86b2d4c033756db178f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.702715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.703084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 23:29:12.714577) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-06 23:29:12.714868) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:29:13 INFO - MultiFileLogger online at 20160406 23:29:13 in /builds/slave/test-pgo 23:29:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:29:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:29:13 INFO - {'append_to_log': False, 23:29:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:29:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:29:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:29:13 INFO - 'branch': 'Mozilla-Beta', 23:29:13 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:13 INFO - 'config_files': ('talos/linux_config.py',), 23:29:13 INFO - 'default_actions': ('clobber', 23:29:13 INFO - 'read-buildbot-config', 23:29:13 INFO - 'download-and-extract', 23:29:13 INFO - 'populate-webroot', 23:29:13 INFO - 'create-virtualenv', 23:29:13 INFO - 'install', 23:29:13 INFO - 'run-tests'), 23:29:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:13 INFO - 'download_minidump_stackwalk': True, 23:29:13 INFO - 'download_symbols': 'ondemand', 23:29:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:29:13 INFO - 'tooltool.py': '/tools/tooltool.py', 23:29:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:29:13 INFO - '/tools/misc-python/virtualenv.py')}, 23:29:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:13 INFO - 'installer_path': 'installer.exe', 23:29:13 INFO - 'log_level': 'info', 23:29:13 INFO - 'log_name': 'talos', 23:29:13 INFO - 'log_to_console': True, 23:29:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:29:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:29:13 INFO - 'opt_config_files': (), 23:29:13 INFO - 'pip_index': False, 23:29:13 INFO - 'sps_profile': False, 23:29:13 INFO - 'sps_profile_interval': 0, 23:29:13 INFO - 'suite': 'dromaeojs', 23:29:13 INFO - 'system_bits': '32', 23:29:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:13 INFO - 'title': 'talos-linux64-ix-044', 23:29:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:13 INFO - 'use_talos_json': True, 23:29:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:29:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:13 INFO - 'work_dir': 'build'} 23:29:13 INFO - ##### 23:29:13 INFO - ##### Running clobber step. 23:29:13 INFO - ##### 23:29:13 INFO - Running pre-action listener: _resource_record_pre_action 23:29:13 INFO - Running main action method: clobber 23:29:13 INFO - rmtree: /builds/slave/test-pgo/build 23:29:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:29:14 INFO - Running post-action listener: _resource_record_post_action 23:29:14 INFO - ##### 23:29:14 INFO - ##### Running read-buildbot-config step. 23:29:14 INFO - ##### 23:29:14 INFO - Running pre-action listener: _resource_record_pre_action 23:29:14 INFO - Running main action method: read_buildbot_config 23:29:14 INFO - Using buildbot properties: 23:29:14 INFO - { 23:29:14 INFO - "project": "", 23:29:14 INFO - "product": "firefox", 23:29:14 INFO - "script_repo_revision": "production", 23:29:14 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:29:14 INFO - "repository": "", 23:29:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:29:14 INFO - "buildid": "20160406210052", 23:29:14 INFO - "pgo_build": "True", 23:29:14 INFO - "basedir": "/builds/slave/test-pgo", 23:29:14 INFO - "buildnumber": 194, 23:29:14 INFO - "slavename": "talos-linux64-ix-044", 23:29:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:29:14 INFO - "platform": "ubuntu64_hw", 23:29:14 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:29:14 INFO - "branch": "mozilla-beta", 23:29:14 INFO - "repo_path": "releases/mozilla-beta", 23:29:14 INFO - "revision": "807dc77c648fe2c8ed29e86b2d4c033756db178f", 23:29:14 INFO - "stage_platform": "linux64-pgo", 23:29:14 INFO - "builduid": "d02798328d1b4be6b41fa4e326b9d388", 23:29:14 INFO - "slavebuilddir": "test" 23:29:14 INFO - } 23:29:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 23:29:14 INFO - Running post-action listener: _resource_record_post_action 23:29:14 INFO - ##### 23:29:14 INFO - ##### Running download-and-extract step. 23:29:14 INFO - ##### 23:29:14 INFO - Running pre-action listener: _resource_record_pre_action 23:29:14 INFO - Running main action method: download_and_extract 23:29:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:29: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')]} 23:29:14 INFO - https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:29:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/test_packages.json 23:29:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/test_packages.json 23:29:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:29:15 INFO - Downloaded 1412 bytes. 23:29:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:29:15 INFO - Using the following test package requirements: 23:29:15 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 23:29:15 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:29:15 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 23:29:15 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'jsshell-linux-x86_64.zip'], 23:29:15 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:29:15 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 23:29:15 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 23:29:15 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 23:29:15 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:29:15 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 23:29:15 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 23:29:15 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:29:15 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:29:15 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')]} 23:29:15 INFO - https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 23:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 23:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 23:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:29:16 INFO - Downloaded 23142361 bytes. 23:29:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:29:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:29:18 INFO - Return code: 0 23:29:18 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:18 INFO - https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 23:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 23:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 23:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:29:27 INFO - Downloaded 23142361 bytes. 23:29:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:29:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:29:29 INFO - Return code: 0 23:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:29 INFO - https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 23:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 23:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 23:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:29:30 INFO - Downloaded 10801548 bytes. 23:29:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:29:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:29:30 INFO - Return code: 0 23:29: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')]} 23:29:30 INFO - https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:29:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 23:29:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 23:29:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 23:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:29:32 INFO - Downloaded 52862833 bytes. 23:29:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 23:29:32 INFO - mkdir: /builds/slave/test-pgo/properties 23:29:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:29:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:29:32 INFO - Contents: 23:29:32 INFO - build_url:https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 23:29:33 INFO - Running post-action listener: _resource_record_post_action 23:29:33 INFO - Running post-action listener: set_extra_try_arguments 23:29:33 INFO - ##### 23:29:33 INFO - ##### Running populate-webroot step. 23:29:33 INFO - ##### 23:29:33 INFO - Running pre-action listener: _resource_record_pre_action 23:29:33 INFO - Running main action method: populate_webroot 23:29:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:29:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:29:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:29:33 INFO - '--tppagecycles', 23:29:33 INFO - '7'], 23:29:33 INFO - 'tests': ['tsvgm']}}, 23:29:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:29:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:29:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:29:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:29:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'tests': ['damp', 'tps']}, 23:29:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['damp', 'tps']}, 23:29:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:29:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:29:33 INFO - 'other': {'tests': ['a11yr', 23:29:33 INFO - 'ts_paint', 23:29:33 INFO - 'tpaint', 23:29:33 INFO - 'sessionrestore', 23:29:33 INFO - 'sessionrestore_no_auto_restore']}, 23:29:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['a11yr', 23:29:33 INFO - 'ts_paint', 23:29:33 INFO - 'tpaint', 23:29:33 INFO - 'sessionrestore', 23:29:33 INFO - 'sessionrestore_no_auto_restore']}, 23:29:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['a11yr', 23:29:33 INFO - 'ts_paint', 23:29:33 INFO - 'tpaint', 23:29:33 INFO - 'sessionrestore', 23:29:33 INFO - 'sessionrestore_no_auto_restore']}, 23:29:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['a11yr', 23:29:33 INFO - 'ts_paint', 23:29:33 INFO - 'tpaint', 23:29:33 INFO - 'sessionrestore', 23:29:33 INFO - 'sessionrestore_no_auto_restore']}, 23:29:33 INFO - 'other_l64': {'tests': ['a11yr', 23:29:33 INFO - 'ts_paint', 23:29:33 INFO - 'tpaint', 23:29:33 INFO - 'sessionrestore', 23:29:33 INFO - 'sessionrestore_no_auto_restore']}, 23:29:33 INFO - 'other_nol64': {'tests': ['a11yr', 23:29:33 INFO - 'ts_paint', 23:29:33 INFO - 'tpaint', 23:29:33 INFO - 'sessionrestore', 23:29:33 INFO - 'sessionrestore_no_auto_restore']}, 23:29:33 INFO - 'svgr': {'tests': ['tsvgx', 23:29:33 INFO - 'tsvgr_opacity', 23:29:33 INFO - 'tart', 23:29:33 INFO - 'tscrollx', 23:29:33 INFO - 'cart']}, 23:29:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['tsvgx', 23:29:33 INFO - 'tsvgr_opacity', 23:29:33 INFO - 'tart', 23:29:33 INFO - 'tscrollx', 23:29:33 INFO - 'cart']}, 23:29:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'tests': ['tp5o']}, 23:29:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'talos_options': ['--e10s'], 23:29:33 INFO - 'tests': ['tp5o']}, 23:29:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'talos_options': ['--xperf_path', 23:29:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:33 INFO - 'tests': ['tp5n']}, 23:29:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:33 INFO - 'talos_options': ['--e10s', 23:29:33 INFO - '--xperf_path', 23:29:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:33 INFO - 'tests': ['tp5n']}}, 23:29:33 INFO - 'talos.zip': {'path': '', 23:29:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:29:33 INFO - Running post-action listener: _resource_record_post_action 23:29:33 INFO - ##### 23:29:33 INFO - ##### Running create-virtualenv step. 23:29:33 INFO - ##### 23:29:33 INFO - Running pre-action listener: _resource_record_pre_action 23:29:33 INFO - Running main action method: create_virtualenv 23:29:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:29:33 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 23:29:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:29:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:29:33 INFO - Using real prefix '/usr' 23:29:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:29:34 INFO - Installing distribute.............................................................................................................................................................................................done. 23:29:36 INFO - Installing pip.................done. 23:29:36 INFO - Return code: 0 23:29:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:36 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 23:29:36 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 23:29:36 INFO - Using env: {'DISPLAY': ':0', 23:29:36 INFO - 'HOME': '/home/cltbld', 23:29:36 INFO - 'LANG': 'en_US.UTF-8', 23:29:36 INFO - 'LANGUAGE': 'en_US:en', 23:29:36 INFO - 'LOGNAME': 'cltbld', 23:29:36 INFO - 'MAIL': '/var/mail/cltbld', 23:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:36 INFO - 'MOZ_NO_REMOTE': '1', 23:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:36 INFO - 'NO_EM_RESTART': '1', 23:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:36 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:36 INFO - 'SHELL': '/bin/bash', 23:29:36 INFO - 'SHLVL': '1', 23:29:36 INFO - 'TERM': 'linux', 23:29:36 INFO - 'TMOUT': '86400', 23:29:36 INFO - 'USER': 'cltbld', 23:29:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:36 INFO - '_': '/tools/buildbot/bin/python'} 23:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:36 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 23:29:36 INFO - Cleaning up... 23:29:36 INFO - Return code: 0 23:29:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:36 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:36 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 23:29:36 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 23:29:36 INFO - Using env: {'DISPLAY': ':0', 23:29:36 INFO - 'HOME': '/home/cltbld', 23:29:36 INFO - 'LANG': 'en_US.UTF-8', 23:29:36 INFO - 'LANGUAGE': 'en_US:en', 23:29:36 INFO - 'LOGNAME': 'cltbld', 23:29:36 INFO - 'MAIL': '/var/mail/cltbld', 23:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:36 INFO - 'MOZ_NO_REMOTE': '1', 23:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:36 INFO - 'NO_EM_RESTART': '1', 23:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:36 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:36 INFO - 'SHELL': '/bin/bash', 23:29:36 INFO - 'SHLVL': '1', 23:29:36 INFO - 'TERM': 'linux', 23:29:36 INFO - 'TMOUT': '86400', 23:29:36 INFO - 'USER': 'cltbld', 23:29:36 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:36 INFO - '_': '/tools/buildbot/bin/python'} 23:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:36 INFO - Downloading/unpacking psutil>=0.7.1 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:29:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:39 INFO - Installing collected packages: psutil 23:29:39 INFO - Running setup.py install for psutil 23:29:39 INFO - building 'psutil._psutil_linux' extension 23:29:39 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 23:29:39 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 23:29:39 INFO - building 'psutil._psutil_posix' extension 23:29:39 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 23:29:39 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 23:29:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:39 INFO - Successfully installed psutil 23:29:39 INFO - Cleaning up... 23:29:39 INFO - Return code: 0 23:29:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:39 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:39 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 23:29:39 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 23:29:39 INFO - Using env: {'DISPLAY': ':0', 23:29:39 INFO - 'HOME': '/home/cltbld', 23:29:39 INFO - 'LANG': 'en_US.UTF-8', 23:29:39 INFO - 'LANGUAGE': 'en_US:en', 23:29:39 INFO - 'LOGNAME': 'cltbld', 23:29:39 INFO - 'MAIL': '/var/mail/cltbld', 23:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:39 INFO - 'MOZ_NO_REMOTE': '1', 23:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:39 INFO - 'NO_EM_RESTART': '1', 23:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:39 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:39 INFO - 'SHELL': '/bin/bash', 23:29:39 INFO - 'SHLVL': '1', 23:29:39 INFO - 'TERM': 'linux', 23:29:39 INFO - 'TMOUT': '86400', 23:29:39 INFO - 'USER': 'cltbld', 23:29:39 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:39 INFO - '_': '/tools/buildbot/bin/python'} 23:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29: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 23:29:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:29:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:29:42 INFO - Installing collected packages: mozsystemmonitor 23:29:42 INFO - Running setup.py install for mozsystemmonitor 23:29:42 INFO - Successfully installed mozsystemmonitor 23:29:42 INFO - Cleaning up... 23:29:42 INFO - Return code: 0 23:29:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:42 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:42 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 23:29:42 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 23:29:42 INFO - Using env: {'DISPLAY': ':0', 23:29:42 INFO - 'HOME': '/home/cltbld', 23:29:42 INFO - 'LANG': 'en_US.UTF-8', 23:29:42 INFO - 'LANGUAGE': 'en_US:en', 23:29:42 INFO - 'LOGNAME': 'cltbld', 23:29:42 INFO - 'MAIL': '/var/mail/cltbld', 23:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:42 INFO - 'MOZ_NO_REMOTE': '1', 23:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:42 INFO - 'NO_EM_RESTART': '1', 23:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:42 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:42 INFO - 'SHELL': '/bin/bash', 23:29:42 INFO - 'SHLVL': '1', 23:29:42 INFO - 'TERM': 'linux', 23:29:42 INFO - 'TMOUT': '86400', 23:29:42 INFO - 'USER': 'cltbld', 23:29:42 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:42 INFO - '_': '/tools/buildbot/bin/python'} 23:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:42 INFO - Downloading/unpacking blobuploader==1.2.4 23:29:42 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 23:29:42 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 23:29:42 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 23:29:42 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 23:29:42 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 23:29:42 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 23:29:45 INFO - Downloading blobuploader-1.2.4.tar.gz 23:29:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:29:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:29:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 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 23:29:45 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 23:29:46 INFO - Downloading docopt-0.6.1.tar.gz 23:29:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:29:46 INFO - Installing collected packages: blobuploader, requests, docopt 23:29:46 INFO - Running setup.py install for blobuploader 23:29:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:29:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:29:46 INFO - Running setup.py install for requests 23:29:46 INFO - Running setup.py install for docopt 23:29:46 INFO - Successfully installed blobuploader requests docopt 23:29:46 INFO - Cleaning up... 23:29:46 INFO - Return code: 0 23:29:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:46 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:46 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 23:29:46 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 23:29:46 INFO - Using env: {'DISPLAY': ':0', 23:29:46 INFO - 'HOME': '/home/cltbld', 23:29:46 INFO - 'LANG': 'en_US.UTF-8', 23:29:46 INFO - 'LANGUAGE': 'en_US:en', 23:29:46 INFO - 'LOGNAME': 'cltbld', 23:29:46 INFO - 'MAIL': '/var/mail/cltbld', 23:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:46 INFO - 'MOZ_NO_REMOTE': '1', 23:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:46 INFO - 'NO_EM_RESTART': '1', 23:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:46 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:46 INFO - 'SHELL': '/bin/bash', 23:29:46 INFO - 'SHLVL': '1', 23:29:46 INFO - 'TERM': 'linux', 23:29:46 INFO - 'TMOUT': '86400', 23:29:46 INFO - 'USER': 'cltbld', 23:29:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:46 INFO - '_': '/tools/buildbot/bin/python'} 23:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:29:47 INFO - Running setup.py (path:/tmp/pip-qiEq17-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:29:47 INFO - Running setup.py (path:/tmp/pip-XPvFQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:29:47 INFO - Running setup.py (path:/tmp/pip-pRh0Vb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:29:47 INFO - Running setup.py (path:/tmp/pip-liqcwG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:29:47 INFO - Running setup.py (path:/tmp/pip-07lO_N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:29:47 INFO - Running setup.py (path:/tmp/pip-MwG6rN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:29:47 INFO - Running setup.py (path:/tmp/pip-Pf1hKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:29:47 INFO - Running setup.py (path:/tmp/pip-z7rGT0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:29:47 INFO - Running setup.py (path:/tmp/pip-n0tCt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:29:47 INFO - Running setup.py (path:/tmp/pip-CUUPgB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:29:47 INFO - Running setup.py (path:/tmp/pip-adHv8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:29:47 INFO - Running setup.py (path:/tmp/pip-OVqFpK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:29:47 INFO - Running setup.py (path:/tmp/pip-qPZyqs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:29:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:29:48 INFO - Running setup.py (path:/tmp/pip-NZLpJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:29:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:29:48 INFO - Running setup.py (path:/tmp/pip-yrEwQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:29:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:29:48 INFO - Running setup.py (path:/tmp/pip-XCpV1Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:29:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:29:48 INFO - Running setup.py (path:/tmp/pip-5kzI6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:29:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:29:48 INFO - Running setup.py install for manifestparser 23:29:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:29:48 INFO - Running setup.py install for mozcrash 23:29:48 INFO - Running setup.py install for mozdebug 23:29:48 INFO - Running setup.py install for mozdevice 23:29:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:29:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:29:48 INFO - Running setup.py install for mozfile 23:29:48 INFO - Running setup.py install for mozhttpd 23:29:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:29:48 INFO - Running setup.py install for mozinfo 23:29:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:29:48 INFO - Running setup.py install for mozInstall 23:29:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Running setup.py install for mozleak 23:29:49 INFO - Running setup.py install for mozlog 23:29:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Running setup.py install for moznetwork 23:29:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Running setup.py install for mozprocess 23:29:49 INFO - Running setup.py install for mozprofile 23:29:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Running setup.py install for mozrunner 23:29:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:29:49 INFO - Running setup.py install for mozscreenshot 23:29:49 INFO - Running setup.py install for moztest 23:29:49 INFO - Running setup.py install for mozversion 23:29:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:29:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:29:50 INFO - Cleaning up... 23:29:50 INFO - Return code: 0 23:29:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:50 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:50 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 23:29:50 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 23:29:50 INFO - Using env: {'DISPLAY': ':0', 23:29:50 INFO - 'HOME': '/home/cltbld', 23:29:50 INFO - 'LANG': 'en_US.UTF-8', 23:29:50 INFO - 'LANGUAGE': 'en_US:en', 23:29:50 INFO - 'LOGNAME': 'cltbld', 23:29:50 INFO - 'MAIL': '/var/mail/cltbld', 23:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:50 INFO - 'MOZ_NO_REMOTE': '1', 23:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:50 INFO - 'NO_EM_RESTART': '1', 23:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:50 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:50 INFO - 'SHELL': '/bin/bash', 23:29:50 INFO - 'SHLVL': '1', 23:29:50 INFO - 'TERM': 'linux', 23:29:50 INFO - 'TMOUT': '86400', 23:29:50 INFO - 'USER': 'cltbld', 23:29:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:50 INFO - '_': '/tools/buildbot/bin/python'} 23:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:29:50 INFO - Running setup.py (path:/tmp/pip-YE9DdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:29:50 INFO - Running setup.py (path:/tmp/pip-6w0zEw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:29:50 INFO - Running setup.py (path:/tmp/pip-_pf80m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:29:50 INFO - Running setup.py (path:/tmp/pip-anTg6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:29:50 INFO - Running setup.py (path:/tmp/pip-PBqF0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:29:50 INFO - Running setup.py (path:/tmp/pip-_e25kk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:29:50 INFO - Running setup.py (path:/tmp/pip-gWmOhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:29:50 INFO - Running setup.py (path:/tmp/pip-Lk2uNu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:29:50 INFO - Running setup.py (path:/tmp/pip-iftFU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:29:50 INFO - Running setup.py (path:/tmp/pip-mYO5ll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:29:50 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)) 23:29:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:29:50 INFO - Running setup.py (path:/tmp/pip-VVOYdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:29:51 INFO - Running setup.py (path:/tmp/pip-eacegX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:29:51 INFO - Running setup.py (path:/tmp/pip-9LKULe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:29:51 INFO - Running setup.py (path:/tmp/pip-3iBH4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:29:51 INFO - Running setup.py (path:/tmp/pip-xTIS0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:29:51 INFO - Running setup.py (path:/tmp/pip-0t4WUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:29:51 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)) 23:29:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:29:51 INFO - Running setup.py (path:/tmp/pip-DjQMCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 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)) 23:29:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:53 INFO - Downloading blessings-1.6.tar.gz 23:29:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:29:54 INFO - Installing collected packages: blessings 23:29:54 INFO - Running setup.py install for blessings 23:29:54 INFO - Successfully installed blessings 23:29:54 INFO - Cleaning up... 23:29:54 INFO - Return code: 0 23:29:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:29:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:29:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:29:54 INFO - Reading from file tmpfile_stdout 23:29:54 INFO - Current package versions: 23:29:54 INFO - argparse == 1.2.1 23:29:54 INFO - blessings == 1.6 23:29:54 INFO - blobuploader == 1.2.4 23:29:54 INFO - docopt == 0.6.1 23:29:54 INFO - manifestparser == 1.1 23:29:54 INFO - mozInstall == 1.12 23:29:54 INFO - mozcrash == 0.16 23:29:54 INFO - mozdebug == 0.1 23:29:54 INFO - mozdevice == 0.48 23:29:54 INFO - mozfile == 1.2 23:29:54 INFO - mozhttpd == 0.7 23:29:54 INFO - mozinfo == 0.9 23:29:54 INFO - mozleak == 0.1 23:29:54 INFO - mozlog == 3.1 23:29:54 INFO - moznetwork == 0.27 23:29:54 INFO - mozprocess == 0.22 23:29:54 INFO - mozprofile == 0.28 23:29:54 INFO - mozrunner == 6.11 23:29:54 INFO - mozscreenshot == 0.1 23:29:54 INFO - mozsystemmonitor == 0.0 23:29:54 INFO - moztest == 0.7 23:29:54 INFO - mozversion == 1.4 23:29:54 INFO - psutil == 3.1.1 23:29:54 INFO - requests == 1.2.3 23:29:54 INFO - wsgiref == 0.1.2 23:29:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:54 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 23:29:54 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 23:29:54 INFO - Using env: {'DISPLAY': ':0', 23:29:54 INFO - 'HOME': '/home/cltbld', 23:29:54 INFO - 'LANG': 'en_US.UTF-8', 23:29:54 INFO - 'LANGUAGE': 'en_US:en', 23:29:54 INFO - 'LOGNAME': 'cltbld', 23:29:54 INFO - 'MAIL': '/var/mail/cltbld', 23:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:54 INFO - 'MOZ_NO_REMOTE': '1', 23:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:54 INFO - 'NO_EM_RESTART': '1', 23:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:54 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:54 INFO - 'SHELL': '/bin/bash', 23:29:54 INFO - 'SHLVL': '1', 23:29:54 INFO - 'TERM': 'linux', 23:29:54 INFO - 'TMOUT': '86400', 23:29:54 INFO - 'USER': 'cltbld', 23:29:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:54 INFO - '_': '/tools/buildbot/bin/python'} 23:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 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)) 23:29:54 INFO - Cleaning up... 23:29:54 INFO - Return code: 0 23:29:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:54 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 23:29:54 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 23:29:54 INFO - Using env: {'DISPLAY': ':0', 23:29:54 INFO - 'HOME': '/home/cltbld', 23:29:54 INFO - 'LANG': 'en_US.UTF-8', 23:29:54 INFO - 'LANGUAGE': 'en_US:en', 23:29:54 INFO - 'LOGNAME': 'cltbld', 23:29:54 INFO - 'MAIL': '/var/mail/cltbld', 23:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:54 INFO - 'MOZ_NO_REMOTE': '1', 23:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:54 INFO - 'NO_EM_RESTART': '1', 23:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:54 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:54 INFO - 'SHELL': '/bin/bash', 23:29:54 INFO - 'SHLVL': '1', 23:29:54 INFO - 'TERM': 'linux', 23:29:54 INFO - 'TMOUT': '86400', 23:29:54 INFO - 'USER': 'cltbld', 23:29:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:54 INFO - '_': '/tools/buildbot/bin/python'} 23:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:54 INFO - Downloading/unpacking jsonschema 23:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:29:56 INFO - Downloading/unpacking functools32 (from jsonschema) 23:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:57 INFO - Downloading functools32-3.2.3-2.tar.gz 23:29:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:29:57 INFO - warning: no files found matching '*.txt' 23:29:57 INFO - no previously-included directories found matching 'build' 23:29:57 INFO - no previously-included directories found matching 'dist' 23:29:57 INFO - no previously-included directories found matching '.git*' 23:29:57 INFO - Installing collected packages: jsonschema, functools32 23:29:57 INFO - Running setup.py install for functools32 23:29:57 INFO - warning: no files found matching '*.txt' 23:29:57 INFO - no previously-included directories found matching 'build' 23:29:57 INFO - no previously-included directories found matching 'dist' 23:29:57 INFO - no previously-included directories found matching '.git*' 23:29:57 INFO - Successfully installed jsonschema functools32 23:29:57 INFO - Cleaning up... 23:29:57 INFO - Return code: 0 23:29:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:57 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 0x7f65392a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12483c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, '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': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', '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 23:29:57 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 23:29:57 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 23:29:57 INFO - Using env: {'DISPLAY': ':0', 23:29:57 INFO - 'HOME': '/home/cltbld', 23:29:57 INFO - 'LANG': 'en_US.UTF-8', 23:29:57 INFO - 'LANGUAGE': 'en_US:en', 23:29:57 INFO - 'LOGNAME': 'cltbld', 23:29:57 INFO - 'MAIL': '/var/mail/cltbld', 23:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:57 INFO - 'MOZ_NO_REMOTE': '1', 23:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:57 INFO - 'NO_EM_RESTART': '1', 23:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:29:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:29:57 INFO - 'SHELL': '/bin/bash', 23:29:57 INFO - 'SHLVL': '1', 23:29:57 INFO - 'TERM': 'linux', 23:29:57 INFO - 'TMOUT': '86400', 23:29:57 INFO - 'USER': 'cltbld', 23:29:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:57 INFO - '_': '/tools/buildbot/bin/python'} 23:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:57 INFO - Downloading/unpacking flake8 23:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:29:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:29:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:30:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:30:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:30:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:30:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:30:00 INFO - no previously-included directories found matching 'docs/_build' 23:30:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:30:00 INFO - Running setup.py install for pep8 23:30:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:30:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:30:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:30:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:30:00 INFO - no previously-included directories found matching 'docs/_build' 23:30:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:30:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:30:00 INFO - Cleaning up... 23:30:00 INFO - Return code: 0 23:30:00 INFO - Running post-action listener: _resource_record_post_action 23:30:00 INFO - Running post-action listener: _start_resource_monitoring 23:30:00 INFO - Starting resource monitoring. 23:30:00 INFO - ##### 23:30:00 INFO - ##### Running install step. 23:30:00 INFO - ##### 23:30:00 INFO - Running pre-action listener: _resource_record_pre_action 23:30:00 INFO - Running main action method: install 23:30:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:30:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:30:00 INFO - Reading from file tmpfile_stdout 23:30:00 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:30:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:30:00 INFO - Reading from file tmpfile_stdout 23:30:00 INFO - Output received: 23:30:00 INFO - Usage: mozinstall [options] installer 23:30:00 INFO - Options: 23:30:00 INFO - -h, --help show this help message and exit 23:30:00 INFO - -d DEST, --destination=DEST 23:30:00 INFO - Directory to install application into. [default: 23:30:00 INFO - "/builds/slave/test-pgo"] 23:30:00 INFO - --app=APP Application being installed. [default: firefox] 23:30:00 INFO - mkdir: /builds/slave/test-pgo/build/application 23:30:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:30:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:30:13 INFO - Reading from file tmpfile_stdout 23:30:13 INFO - Output received: 23:30:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:30:13 INFO - Running post-action listener: _resource_record_post_action 23:30:13 INFO - ##### 23:30:13 INFO - ##### Running run-tests step. 23:30:13 INFO - ##### 23:30:13 INFO - Running pre-action listener: _resource_record_pre_action 23:30:13 INFO - Running main action method: run_tests 23:30:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:30:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:30:13 INFO - Python 2.7.3 23:30:13 INFO - Return code: 0 23:30:13 INFO - grabbing minidump binary from tooltool 23:30: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')]} 23:30:13 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 0x12d75a0>, '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 0x12d84a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8950>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:30:13 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 23:30:13 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 23:30:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:13 INFO - Return code: 0 23:30:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:30:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:30:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:30:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:30:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:30:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:30:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:30:14 INFO - Return code: 0 23:30:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 23:30:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 23:30:14 INFO - Using env: {'DISPLAY': ':0', 23:30:14 INFO - 'HOME': '/home/cltbld', 23:30:14 INFO - 'LANG': 'en_US.UTF-8', 23:30:14 INFO - 'LANGUAGE': 'en_US:en', 23:30:14 INFO - 'LOGNAME': 'cltbld', 23:30:14 INFO - 'MAIL': '/var/mail/cltbld', 23:30:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:30:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:14 INFO - 'MOZ_NO_REMOTE': '1', 23:30:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:14 INFO - 'NO_EM_RESTART': '1', 23:30:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:30:14 INFO - 'PWD': '/builds/slave/test-pgo', 23:30:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:30:14 INFO - 'SHELL': '/bin/bash', 23:30:14 INFO - 'SHLVL': '1', 23:30:14 INFO - 'TERM': 'linux', 23:30:14 INFO - 'TMOUT': '86400', 23:30:14 INFO - 'USER': 'cltbld', 23:30:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975', 23:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:14 INFO - '_': '/tools/buildbot/bin/python'} 23:30:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 23:30:14 INFO - mozversion application_buildid: 20160406210052 23:30:14 INFO - mozversion application_changeset: 807dc77c648fe2c8ed29e86b2d4c033756db178f 23:30:14 INFO - mozversion application_display_name: Firefox 23:30:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:14 INFO - mozversion application_name: Firefox 23:30:14 INFO - mozversion application_remotingname: firefox 23:30:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:30:14 INFO - mozversion application_vendor: Mozilla 23:30:14 INFO - mozversion application_version: 46.0 23:30:14 INFO - mozversion platform_buildid: 20160406210052 23:30:14 INFO - mozversion platform_changeset: 807dc77c648fe2c8ed29e86b2d4c033756db178f 23:30:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:30:14 INFO - mozversion platform_version: 46.0 23:30:14 INFO - using testdate: 1460010614 23:30:14 INFO - actual date: 1460010614 23:30:14 INFO - starting webserver on 'localhost:58955' 23:30:14 INFO - SUITE-START | Running 3 tests 23:30:14 INFO - TEST-START | dromaeo_css 23:30:14 INFO - operating with platform_type : linux_ 23:30:14 INFO - Initialising browser for dromaeo_css test... 23:30:14 INFO - TEST-INFO | started process 8272 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW2XQQR/profile http://localhost:58955/getInfo.html) 23:30:18 INFO - PROCESS | 8272 | __metrics Screen width/height:1600/1200 23:30:18 INFO - PROCESS | 8272 | colorDepth:24 23:30:18 INFO - PROCESS | 8272 | Browser inner width/height: 1024/697 23:30:18 INFO - PROCESS | 8272 | __metrics 23:30:18 INFO - PROCESS | 8272 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:30:19 INFO - TEST-INFO | 8272: exit 0 23:30:19 INFO - Browser initialized. 23:30:19 INFO - Running cycle 1/1 for dromaeo_css test... 23:30:19 INFO - TEST-INFO | started process 8360 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW2XQQR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:31 INFO - PROCESS | 8360 | RSS: Main: 136818688 23:30:31 INFO - PROCESS | 8360 | 23:31:22 INFO - PROCESS | 8360 | 1460010682064 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] 23:33:30 INFO - PROCESS | 8360 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58955/tests/dromaeo/cssquery-ext.html) 23:33:31 INFO - PROCESS | 8360 | RSS: Main: 223223808 23:33:31 INFO - PROCESS | 8360 | 23:36:33 INFO - PROCESS | 8360 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-ext.html (next: http://localhost:58955/tests/dromaeo/cssquery-jquery.html) 23:36:33 INFO - PROCESS | 8360 | RSS: Main: 214544384 23:36:33 INFO - PROCESS | 8360 | 23:39:35 INFO - PROCESS | 8360 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58955/tests/dromaeo/cssquery-mootools.html) 23:39:36 INFO - PROCESS | 8360 | RSS: Main: 216104960 23:39:36 INFO - PROCESS | 8360 | 23:42:38 INFO - PROCESS | 8360 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58955/tests/dromaeo/cssquery-prototype.html) 23:42:38 INFO - PROCESS | 8360 | RSS: Main: 198189056 23:42:38 INFO - PROCESS | 8360 | 23:45:41 INFO - PROCESS | 8360 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58955/tests/dromaeo/cssquery-yui.html) 23:45:41 INFO - PROCESS | 8360 | RSS: Main: 203636736 23:45:41 INFO - PROCESS | 8360 | 23:48:43 INFO - PROCESS | 8360 | Cycle 1(1): loaded http://localhost:58955/tests/dromaeo/cssquery-yui.html (next: http://localhost:58955/tests/dromaeo/cssquery-dojo.html) 23:48:44 INFO - PROCESS | 8360 | RSS: Main: 246513664 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | __start_tp_report 23:48:44 INFO - PROCESS | 8360 | _x_x_mozilla_page_load 23:48:44 INFO - PROCESS | 8360 | _x_x_mozilla_page_load_details 23:48:44 INFO - PROCESS | 8360 | |i|pagename|runs| 23:48:44 INFO - PROCESS | 8360 | |0;dojo.html;3229.5640088588043;3285.2608163163277;3315.5524004259432;3324.285278665088;3344.71569916557;5249.92125118123;5275.498827611375;5276;5297.284866543016;5298.814541491049;5295.8146464873735;5310.946890531093;5314.867128321794;5327.520523152915;5336.252924590561;4830.347903033098;4837.0567739290855;4851.902961940767;4874.65877388583;4896.069746748124;4864.124457597631;4877.122118018755;4931.80272789088;4937.210046392578;4939.036887806879;4793.90412191756;4860.295257187706;4890.364252647151;4905.068037072945;4936.7037977721275;4878.609711223111;4895.6083513318845;4898.583620392271;4900.558949694509;4930.556249937487;4749.4775574686755;4810.206315957863;4849.927251091236;4872.171730805771;4879.414470263591;5123.7438128093445;5197.66215196011;5239.607029472805;5244.763985620656;5270.92093618596;5556.083246264361;5635.830925072254;5639.351474580394;5645.887082258332;5646.096624540054;5534.806281780158;5604.159376093618;5692.37383887772;5695.316562012585;5697.914531282034;5343.385510666284;5374.946250537523;5402.243685883979;5404.756785944642;5427.810026649087;5833.620814647034;5867.73595188209;5869.442402971797;5870.295564532284;5877.059670452707;5517.393086760533;5579.38626751057;5629.437056294338;5629.943700562942;5654.095344744821;5726.284214473191;5729.25519682447;5733.054046082433;5739.540836733051;5740.397258287903;5677.971610141923;5679.2333035040565;5682.488576028178;5682.886342273131;5683.687397193194;5591.41290164535;5620.606557541015;5635.6618602883955;5656.066748986371;5681.34664513578;4401.845935392246;4411.647068234598;4413.3821265022925;4417.116576684676;4438.045820148684;3963.8216280267457;3970.06703424695;3990.780507072081;4015.738976966488;4023.0746928206677;5306.416294207634;5321.148616221386;5386.218998245233;5399.622026458111;5489.945100549024;5761.88476230473;5765.94234057654;5772.480476757112;5799;5801.419858014165;5433.510984011379;5465.890682186334;5467.535259502987;5467.890642187134;5473.233747275384;4847.030593881238;4914.287428322945;4991.176455884811;5025;5083.644144909821;5805.071188609802;5805.274340707411;5807.593468457252;5817.88364232713;5826.359100498942;5689.971550142222;5692.7722891083895;5693;5697.059985102412;5714.5999780015;5633.521150702072;5777.133429985536;5832.708364581838;5873.50075243592;5924.52603791687;5623.437656234344;5648.181013753065;5667.914981275202;5669.943300567106;5672.064109422065;5557.249771280825;5730.856728581819;5733;5736.254286942671;5737.74180161902;5409.269748583891;5628.380878103487;5695.800646977502;5702.087665973424;5726.74229659658;5534.308211473566;5535.280413546374;5537;5538.335399752055;5542.0855558832345;5327.600429967845;5455.427180146027;5477.561795056306;5481.287432633732;5508.91736623943;5552.444755524577;5635.0702134147405;5650.802221922213;5656.321241451053;5661.915071274017;5541.473560011793;5573.414791446839;5575.080111781673;5580.162975553537;5582.162675598693 23:48:44 INFO - PROCESS | 8360 | |1;ext.html;515.9071367153911;549.1049589169653;574.744238813728;574.8646423313953;577.6765011593508;30913.22716932075;38857;38870;38937.22125557487;38951.80524097382;43147.568524314745;43311;43346.34980475288;43465;43652;8622.267107295871;8907.599158037872;8909.420887642314;8927.330450216226;8940.10598940104;8668.089850565695;8802.427842190269;8811.295096392305;8814.86777698335;8825.558722063903;8823.382363234545;8859.955700221522;8862.778430539223;8878.778030549223;8893.199612034916;8680.782980425509;8788.560571971408;8792.07683193265;8803.29573634114;8805;8785.7803554911;8844.823103537894;8902.688405905763;8915.821683566357;8918.554072296423;42440.36339454911;42934;43084.78457607723;43098.78450607758;43193.13613727739;3644.817759112034;3751.306008388457;3780.6030366811365;4078.5921407859273;4349.69552131351;32688;32859.50710739317;32891;32975.175620609436;33384.16539586506;4237.4915010198665;4282.700210985232;4292.29177185764;4335.436393268887;4393.978030109861;290589;290857;291434;291792;292518;57944.13083803746;59483;63452.36547634557;72930;74845;58866.41133588609;59120.40879591235;59152.40847591555;59152.7042364794;59210.70394647999;17687.469375918743;17823.910880445514;17875.553111172063;17885.19516621729;17899.73150402745;14181.078229915023;14262.500812471513;14278.214698191492;14284.928575357057;14562.85437145615;21436.249731259642;21985.450363741034;21989;21994.560108797734;22073.668894966588;7599.658015389321;7831;7873.881891771628;7945.260213764928;7947.324477419368;986.4820968991194;1021.5760459409262;1046.4610725476387;1061.5806756331206;1063.9574417023232;29625.85187074094;29626.703732962393;33102;33240.335193296;33392;1122.8764835868049;1130.2088538023415;1136.613551392514;1191.4162060590422;1208.275034979023;13772.098061233648;14701.18947614339;14803.925980370244;15644.374225031099;15843.207839607974;437560;438413;438591;439264;444640;56968.715156423954;57533;57629;57638.7118064407;57702.7114864423;1457.7521821290406;1474.8303945046457;1480.7852861335261;1485.6434455730764;1501.527018989015;31696.683033169375;31932.680673192972;32000.5199922006;32351.35297294088;32604.021879343658;47100.58698239058;47793;52131.739341304565;52692;52780;310657;314642;314897;316157;316719;44670.553294467936;45148;45464.77267613641;45500;46440.767796160806;47804.2829357553;48143.27785083157;48332.51667483421;48744;49323;40477.79761101176;41644.79177604214;41718.16563668649;42141;43082;41143;41553.37669935014;41605.58394416017;41875.7906210467;42064.1587168261;40871.1825763489;40938.79530602447;41187.588124118374;41594.1681166381;41968.370474443516;31883.521747174276;33108.337833243684;37277.81361093177;37444.62555374411;39629;25256.989720410977;27651;27951.021714239905;28036.85981570079;28039.439211215253 23:48:44 INFO - PROCESS | 8360 | |2;jquery.html;368.6866163760802;373.6543697080201;377.52997518089984;385.52387801065686;388.9630485103916;14498.13011219325;15887.44393946212;17103.82896171038;19057.142428590712;19146.42560723177;17300.096989331163;17842.19710113045;17880.64238715225;17918.19368128434;18078;4331.891702707426;5579.609427340088;5750.654960702372;5778.133280007991;5778.884422311551;4403.229434848905;5974.133750606159;6204.162438070848;6238.688065596724;6241.687915604224;6148.200733904586;6225.284092329395;6310.368963103699;6313.77901773438;6337.239531256233;5130.153524668425;5329.653572517774;6224.159738435299;6241.968790156043;6289.842753931142;5086.872828179288;5136.820211292624;5156.484351564851;5162.638615296931;5170.405403378622;12453.875461245361;12506.249625022438;12556.121071524996;12610.747785044248;18614.813851861443;745.8993035940188;746.2649290448903;746.4215233194263;2077.98961005194;2398.806583746205;10829.336530775427;13577.049606527547;13920.443182272798;13982.300884955712;14167.929160354235;1887.5847313591125;1892.6971684530408;1982.9107690153978;2006.7491563554556;2013.4563667809755;66154;66456.66771666158;66821.33178668248;67282.3271767281;67887.32112678909;16014.919925400298;16056.43802466908;16115.355385784671;16204.513864584082;16269.10519921392;25403.491930161665;25610.231693049238;25915;25943.351416214744;26048.609270860954;7814.296713295717;8007.1592482788465;8024.0772311184965;8039.799005024921;8095.23095305945;8101.392395570356;8117.431779775359;8173.223543763333;8174.059983101901;8287.171282871665;4222.852200172979;4353.978230108829;4394.252976993918;4499;4559.247724125482;1833.8624603154817;1853.5458812591;1865.2632210276865;1900.4393703857395;1916.0802814648769;918.8897332320164;954.9236061115095;1093.9343639381664;1109.7281166114353;1123.118352093619;14891.255437228096;15073.397064117531;16482.917585411997;16743.91628041852;17319.653606928045;994.8408254679216;1007.9596816127273;1032.2747945424087;1034.4672493665769;1123.466353482106;9152.72541823733;9527.237820974444;9821.508924553744;10355.43045132525;10363.430011349297;446632;448864;451562;454958;669874;64081.679591602675;80872.59563702262;81868;84650.57674711588;85832.57083714541;1098.593520397458;1141.149843366697;1196.6589521986193;1218.500414829933;1228.582282024116;14680;14959.626009349853;15248.466303679761;15275.541733748005;15492.767608485656;31971.721131155424;32034.519482208252;32114;32934.99999999904;35515.46726799152;41418.58581414147;42938.35592466178;43369.78315108404;45974.310385343575;46832;7222.855542889008;7248.202697703354;7349.118105827335;7490.70037198506;7802.297793198412;10913.39976301311;11130.443477826238;11418.543258269909;11643.88356116428;11935.641930742091;10133.03736145065;10136.290459668047;10291.22815788804;10613.9469302653;10622.415767132881;9864;9930.354526955725;10211.693649190536;10429.3687852561;10509.106725928381;10179.338343007681;10480.475976201313;10705.19711021661;10817.56729730802;10957.890421096006;7577.5453472791805;7731.7680469586;7812.335951444191;7828.099768526465;7881.724139655084;9171.908280917105;9850.852237216592;10774.515146818256;10997.560097596006;11026.44867756625 23:48:44 INFO - PROCESS | 8360 | |3;mootools.html;1389.8332200135985;1539.038101186758;1558.9610259743508;1781.7149256119023;1894.2328357015413;7520.623968801566;8160.306373958213;8348.081711011791;8367.958160209191;8368.58157092146;8197.549134797584;8394.748157555268;8410.285125764318;8414.873776893337;8418.200270974263;2462.1136390899305;2480.8635525046116;2488.5645012122895;2489.0914816092177;2490.4272017436;2358.6226203807396;2429.79346755526;2430.9392265193424;2431.732509423962;2443.926682199537;2421.406755344943;2426.708794944609;2481.6153496208117;2494.3140636325065;2510.422602801357;2429.9028038878514;2437.305367970129;2437.683101196842;2523.1421316752394;2524.432002799374;2458.409981604402;2479.82641215115;2488.14159115105;2489.3278814720106;2514.5473814713528;8472.237498625153;8511.787205319855;8516.361272904556;8519.361047921431;8523.659053637846;5161.948380516184;5295.338082739658;5304.469553044703;5314.548263397616;5315.362156541201;3335.166208447888;3364.6467120952193;3375.71306438953;3407.7103446206856;3421.9486707699402;1069.1500257295468;1078.3044936016227;1080.4597701149426;1092.8797832238447;1098.1653943003296;11859.347735874524;11875.287482750977;11894;11944.820827687505;11946.522139114424;4664.673472856867;4684.812607495662;4734.337192793012;4744.7627618618935;4802.615790736732;10075.143612792848;10077.949610252048;10079.69760907174;10093.69718908434;10108.342957707726;5294.602904782079;5326.627136100436;5331.626786125012;5334.5732341412595;5338.279332290091;4218.78906054696;4361.433013708261;4361.454818147731;4624.630029597692;4863.221884498464;4035.3139966205817;4052;4065.2479291331197;4103.958960410358;4108.322126849036;1326.2374134872487;1339.2232505146992;1343.8857697095661;1351.2568087551808;1356.572679605921;1410.8871290296752;1449.282605110456;1461.6492041909864;1463.6194589406618;1474.292339676961;7831.373490120891;7940;8243.793905152299;8269.751907442665;8273.46222495548;1157.6064138193055;1183.47335435732;1205.8432403787451;1216.4829947272374;1237.2329155923205;6264.279607845065;6295.842603934938;6318.273398559132;6341.397567231105;6393.584417012879;9891.554880030415;10232.6418575351;10391.012853778879;10391.220658450646;10394.16846652266;10209.744756381002;10265;10461.424621645883;10461.633842815465;10463.110635595907;7781.5331080135375;7784.688612455551;7879.33025692811;7881.802954926058;7888.447808653339;7791.727289544839;7838.490498117604;7842.372610191057;7843.176466470938;7971.402144839044;8504.787380315542;8694.434861733967;8975.50634715097;9091.590878410356;9230.78461169328;8717.084706105768;8949.105089490999;9138.634454622006;9163.541822908961;9206.447613143233;6661.833454163685;6868.690908909211;7161.856762864818;7342.449316301406;7446.851062978819;7747.72882949094;7776.183500732342;7796.766097017098;7816.687332506636;7852.882206766789;7441.739539116105;7555.622218888923;7624.390048795972;7726.1114971776715;7731.265529774662;7444.888326675213;7480.812979675552;7533.886991695019;7624.5425274483705;7637.389008879165;7714.652840622073;7716;7758.728444504415;7764;7768.456208065381;7026.1217347831525;7054.788356349318;7097.574145551283;7107.857842843217;7169.641517924188;6941.062956500808;6971.372576468142;7244.094488188976;7247.782566523013;7294.379977701955 23:48:44 INFO - PROCESS | 8360 | |4;prototype.html;354.88643634037106;358.7650089191577;360.59793330436565;360.80877135118396;360.97292703047276;5891.410858914106;6020.0668896321085;6057.030875059997;6063.636181829088;6107.328193898667;5783.913241301373;5962.135490353896;5964.552658550615;5985.431384018511;6003.459688628022;4678.485366609671;4680.719156850591;4682.719036857782;4688.742119183444;4688.765561721917;4516.593506584407;4566.6575006874455;4602.562756538124;4644.024754801496;4689.554492323224;4585.2892801615635;4611.5619016193405;4627.467841198271;4629.6759226853965;4643;4641.164590373748;4646.721196728207;4647.209974304376;4650.604698600623;4659.78845500169;4115.135821477494;4115.670746340285;4132;4143.357779544175;4143.647789937859;5610.635308704962;5705.4294570543025;5715.885682286373;5719.656820590778;5721.4564616361795;5342.759575819058;5407.3781515125875;5409.648372855791;5418.620696551243;5420.13277875538;6055.576109672281;6325.0828629848875;6341.636548142172;6341.936580634181;6345.9365406345805;4389.078293558325;4478.910421791546;4556.498785133633;4570.88572785683;4582.1293954148605;6522.184726909137;6622.53642245043;6627.73489060437;6627.80116596498;6630.303818099078;4706.176419126639;4707.95292047082;4707.95292047082;4713.57577817998;4713.599344055794;4699.201135806921;4767.332573439721;4797.40032495938;4800.015996720664;4823.9517604824205;5431.266778984866;5437.13005919051;5439.292891924104;5452.127659574449;5454.8909021819345;6373.649449280241;6388.648624325614;6417.294097649255;6417.871642567123;6422.550421470452;1660.892042017265;1675.9832401675826;1677;1677.689627418907;1704.7357659562788;1177.1583317927723;1180.9291442513477;1187.5427960235372;1194.6595220362155;1195.5038658956435;6195.2255968004;6199.504039676815;6215.223097112861;6217.253929528395;6219.813405597839;6546.967265163644;6553.508486863504;6554.3445655435025;6554.737810487527;6560.147180866456;6048.848778780566;6207.875842483216;6208.4722798561725;6217.6891155442045;6218.9378106219265;3517.9120521987156;3543.4684797280097;3548.2193917338145;3548.6628770266784;3549;6760.290169532227;6768.289329620417;6769.72921083161;6798.082258895085;6798.490113241527;6644.870372036766;6810.6254156020905;6810.965945170243;6812.114425124702;6812.4550035997;6775.830604234933;6779.3220677932795;6787.966060169766;6789.2871248518195;6794.796156115324;6337.7148028337915;6493.383128602775;6498.610083395011;6628.436582890508;6643.468522518284;6504.38208370204;6512.934870651422;6520.217573891164;6537.738490460329;6540.705668245036;6731.360520750521;6740.764073257413;6741.089952856301;6762.695678694372;6776.525643204928;4561.794719237576;4641.675082744176;4697.0840686065885;4698.013417182293;4705.411823522059;6640.07039014548;6640.867182656417;6641.435477984232;6647.135872336566;6647.169103862017;6462.579932304385;6482.286948435574;6482.319356467503;6482.935170648422;6486.513511486563;6320.810375688737;6392.744290228339;6453.967730161319;6457;6474.546781725422;6308.873822523616;6366;6366.299707032315;6369.235691717024;6373.840653983688;6440.967795160994;6486.091947127312;6488.610683358825;6488.837779055561;6491.221053473613;6233.376662333731;6336.683165841781;6343.809685709436;6343.9849624059925;6350 23:48:44 INFO - PROCESS | 8360 | |5;yui.html;822.3667775812623;919.8620206968958;926.6664000959657;937.6343226141806;943.9292053096019;13584.3207839608;13732.450701971935;13806.102603330777;13831.100978436407;13840;12253.081018923594;13433.529826456075;13483.325833708324;13509.729805403911;13513.189208647487;733.5928559649392;841.7685136587427;842.0568962761715;844.7127976487993;872.0451106038877;833.1834801894147;833.1918039501674;833.9374546908975;834.3742193354984;879.560219890055;770.1643716567503;774.1484367196095;876.5222953490331;879.8416285068685;925.1118925831211;862.1378621378622;862.590269621934;863.5595846118462;868.9522076285801;897.2104547997753;637.4772686397156;638.4668801550711;638.4955884850962;654.7315600603778;681.3595220492721;13589;14132.576022719335;14140.858591414057;14175.78736318956;14191.574252772434;13080.084394092417;13608.591742247749;14350.569482915425;14535.709285814224;14552.126872387691;11183;11206.327620342723;11330.71673208168;11466.2546934449;11495;3877.4765406670303;3920.313945059632;3942.7831469269177;3944.073142811437;3998.52017757868;51066.23400648993;51221.487785122044;53187.46812531903;53243.73378133123;53504.46495535034;10999;11032.172587056002;11136.109111271078;11165.274257173258;11370.658880233606;20540.589188216152;20592.382228533166;20614.793852061586;20622.175112995614;20630.793692063187;7879.803004924923;7906.090799558009;7936.801579960547;7943.205679432011;8044.798880028046;4433;4469.083837813306;4529.705569137996;4578.084383123389;4646.233371493733;3168.0337497063156;3195.7283630891634;3197.76016798741;3205.951910721341;3210.5826242588782;586.3696526234315;597.0268462406336;603.2067830802481;603.2579926690196;613.2487702564323;690.2476300832117;710.5417006031081;712.6187489693093;713.6503113474464;745.7874505765939;9097.590608422637;9381.202597779129;9432.90567094334;9551.856722149174;9667.613295468243;614.9046897730769;639.2424976402884;655.8262060553957;673.6598018000878;682.6347903871405;4241.130568233505;4731.550502702306;4737.123632128068;4789.281607758864;4823.975880120647;54775.72612136914;55663;55810.72094639582;60894.69552652297;61684.69157654183;46944.183348998486;47526.76236618864;48178.518214818105;48285;48668.51331486711;46691.29963050557;48580.514194858304;49210.52368428881;49492.25761613579;50096.24855627168;9241.168294853496;9367.859482107637;9427.481488518197;9526.095020972996;9555.378900371454;34932;35070.47394289139;35671.46492802558;39042.2191556173;39240.60759392484;46883.29675054945;47399.76300118477;47632.7618361906;48046.5195348042;48184;12687.936560317139;12974.545890894151;13023.827855493051;13130.606081817561;13253.204807711569;13822.93088534551;13849.515266966011;14020.719585608434;14064.859351406763;14071.296435177996;11628.94185529067;11685.00677442393;12645.304508252135;13081.607551773463;13181.538646147723;11859.110566707704;11928.284302941851;12234.388280585757;12437.875621243671;12630.494780209056;12598.370081495705;12695.301758403377;12764.808527871903;12798.16811907223;12949.287789171685;10771.299865508718;10781;10959.780804384027;11093.278936869077;11184.384858832842;10756.677299681021;10902.345859248471;10905.34567925927;11017.44912754375;11030.724231894266 23:48:44 INFO - PROCESS | 8360 | __end_tp_report 23:48:44 INFO - PROCESS | 8360 | __start_cc_report 23:48:44 INFO - PROCESS | 8360 | _x_x_mozilla_cycle_collect,707 23:48:44 INFO - PROCESS | 8360 | __end_cc_report 23:48:44 INFO - PROCESS | 8360 | __startTimestamp1460011724237__endTimestamp 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | ------- Summary: start ------- 23:48:44 INFO - PROCESS | 8360 | Number of tests: 6 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | [#0] dojo.html Cycles:165 Average:5308.09 Median:5534.31 stddev:559.44 (10.1%) stddev-sans-first:536.87 23:48:44 INFO - PROCESS | 8360 | Values: 3229.6 3285.3 3315.6 3324.3 3344.7 5249.9 5275.5 5276.0 5297.3 5298.8 5295.8 5310.9 5314.9 5327.5 5336.3 4830.3 4837.1 4851.9 4874.7 4896.1 4864.1 4877.1 4931.8 4937.2 4939.0 4793.9 4860.3 4890.4 4905.1 4936.7 4878.6 4895.6 4898.6 4900.6 4930.6 4749.5 4810.2 4849.9 4872.2 4879.4 5123.7 5197.7 5239.6 5244.8 5270.9 5556.1 5635.8 5639.4 5645.9 5646.1 5534.8 5604.2 5692.4 5695.3 5697.9 5343.4 5374.9 5402.2 5404.8 5427.8 5833.6 5867.7 5869.4 5870.3 5877.1 5517.4 5579.4 5629.4 5629.9 5654.1 5726.3 5729.3 5733.1 5739.5 5740.4 5678.0 5679.2 5682.5 5682.9 5683.7 5591.4 5620.6 5635.7 5656.1 5681.3 4401.8 4411.6 4413.4 4417.1 4438.0 3963.8 3970.1 3990.8 4015.7 4023.1 5306.4 5321.1 5386.2 5399.6 5489.9 5761.9 5765.9 5772.5 5799.0 5801.4 5433.5 5465.9 5467.5 5467.9 5473.2 4847.0 4914.3 4991.2 5025.0 5083.6 5805.1 5805.3 5807.6 5817.9 5826.4 5690.0 5692.8 5693.0 5697.1 5714.6 5633.5 5777.1 5832.7 5873.5 5924.5 5623.4 5648.2 5667.9 5669.9 5672.1 5557.2 5730.9 5733.0 5736.3 5737.7 5409.3 5628.4 5695.8 5702.1 5726.7 5534.3 5535.3 5537.0 5538.3 5542.1 5327.6 5455.4 5477.6 5481.3 5508.9 5552.4 5635.1 5650.8 5656.3 5661.9 5541.5 5573.4 5575.1 5580.2 5582.2 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | [#1] ext.html Cycles:180 Average:53180.11 Median:42102.58 stddev:93175.11 (221.3%) stddev-sans-first:93352.59 23:48:44 INFO - PROCESS | 8360 | Values: 515.9 549.1 574.7 574.9 577.7 30913.2 38857.0 38870.0 38937.2 38951.8 43147.6 43311.0 43346.3 43465.0 43652.0 8622.3 8907.6 8909.4 8927.3 8940.1 8668.1 8802.4 8811.3 8814.9 8825.6 8823.4 8860.0 8862.8 8878.8 8893.2 8680.8 8788.6 8792.1 8803.3 8805.0 8785.8 8844.8 8902.7 8915.8 8918.6 42440.4 42934.0 43084.8 43098.8 43193.1 3644.8 3751.3 3780.6 4078.6 4349.7 32688.0 32859.5 32891.0 32975.2 33384.2 4237.5 4282.7 4292.3 4335.4 4394.0 290589.0 290857.0 291434.0 291792.0 292518.0 57944.1 59483.0 63452.4 72930.0 74845.0 58866.4 59120.4 59152.4 59152.7 59210.7 17687.5 17823.9 17875.6 17885.2 17899.7 14181.1 14262.5 14278.2 14284.9 14562.9 21436.2 21985.5 21989.0 21994.6 22073.7 7599.7 7831.0 7873.9 7945.3 7947.3 986.5 1021.6 1046.5 1061.6 1064.0 29625.9 29626.7 33102.0 33240.3 33392.0 1122.9 1130.2 1136.6 1191.4 1208.3 13772.1 14701.2 14803.9 15644.4 15843.2 437560.0 438413.0 438591.0 439264.0 444640.0 56968.7 57533.0 57629.0 57638.7 57702.7 1457.8 1474.8 1480.8 1485.6 1501.5 31696.7 31932.7 32000.5 32351.4 32604.0 47100.6 47793.0 52131.7 52692.0 52780.0 310657.0 314642.0 314897.0 316157.0 316719.0 44670.6 45148.0 45464.8 45500.0 46440.8 47804.3 48143.3 48332.5 48744.0 49323.0 40477.8 41644.8 41718.2 42141.0 43082.0 41143.0 41553.4 41605.6 41875.8 42064.2 40871.2 40938.8 41187.6 41594.2 41968.4 31883.5 33108.3 37277.8 37444.6 39629.0 25257.0 27651.0 27951.0 28036.9 28039.4 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | [#2] jquery.html Cycles:180 Average:27466.32 Median:34225.23 stddev:82277.81 (240.4%) stddev-sans-first:82483.46 23:48:44 INFO - PROCESS | 8360 | Values: 368.7 373.7 377.5 385.5 389.0 14498.1 15887.4 17103.8 19057.1 19146.4 17300.1 17842.2 17880.6 17918.2 18078.0 4331.9 5579.6 5750.7 5778.1 5778.9 4403.2 5974.1 6204.2 6238.7 6241.7 6148.2 6225.3 6310.4 6313.8 6337.2 5130.2 5329.7 6224.2 6242.0 6289.8 5086.9 5136.8 5156.5 5162.6 5170.4 12453.9 12506.2 12556.1 12610.7 18614.8 745.9 746.3 746.4 2078.0 2398.8 10829.3 13577.0 13920.4 13982.3 14167.9 1887.6 1892.7 1982.9 2006.7 2013.5 66154.0 66456.7 66821.3 67282.3 67887.3 16014.9 16056.4 16115.4 16204.5 16269.1 25403.5 25610.2 25915.0 25943.4 26048.6 7814.3 8007.2 8024.1 8039.8 8095.2 8101.4 8117.4 8173.2 8174.1 8287.2 4222.9 4354.0 4394.3 4499.0 4559.2 1833.9 1853.5 1865.3 1900.4 1916.1 918.9 954.9 1093.9 1109.7 1123.1 14891.3 15073.4 16482.9 16743.9 17319.7 994.8 1008.0 1032.3 1034.5 1123.5 9152.7 9527.2 9821.5 10355.4 10363.4 446632.0 448864.0 451562.0 454958.0 669874.0 64081.7 80872.6 81868.0 84650.6 85832.6 1098.6 1141.1 1196.7 1218.5 1228.6 14680.0 14959.6 15248.5 15275.5 15492.8 31971.7 32034.5 32114.0 32935.0 35515.5 41418.6 42938.4 43369.8 45974.3 46832.0 7222.9 7248.2 7349.1 7490.7 7802.3 10913.4 11130.4 11418.5 11643.9 11935.6 10133.0 10136.3 10291.2 10613.9 10622.4 9864.0 9930.4 10211.7 10429.4 10509.1 10179.3 10480.5 10705.2 10817.6 10957.9 7577.5 7731.8 7812.3 7828.1 7881.7 9171.9 9850.9 10774.5 10997.6 11026.4 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | [#3] mootools.html Cycles:180 Average:5946.05 Median:5294.97 stddev:3065.33 (57.9%) stddev-sans-first:3054.79 23:48:44 INFO - PROCESS | 8360 | Values: 1389.8 1539.0 1559.0 1781.7 1894.2 7520.6 8160.3 8348.1 8368.0 8368.6 8197.5 8394.7 8410.3 8414.9 8418.2 2462.1 2480.9 2488.6 2489.1 2490.4 2358.6 2429.8 2430.9 2431.7 2443.9 2421.4 2426.7 2481.6 2494.3 2510.4 2429.9 2437.3 2437.7 2523.1 2524.4 2458.4 2479.8 2488.1 2489.3 2514.5 8472.2 8511.8 8516.4 8519.4 8523.7 5161.9 5295.3 5304.5 5314.5 5315.4 3335.2 3364.6 3375.7 3407.7 3421.9 1069.2 1078.3 1080.5 1092.9 1098.2 11859.3 11875.3 11894.0 11944.8 11946.5 4664.7 4684.8 4734.3 4744.8 4802.6 10075.1 10077.9 10079.7 10093.7 10108.3 5294.6 5326.6 5331.6 5334.6 5338.3 4218.8 4361.4 4361.5 4624.6 4863.2 4035.3 4052.0 4065.2 4104.0 4108.3 1326.2 1339.2 1343.9 1351.3 1356.6 1410.9 1449.3 1461.6 1463.6 1474.3 7831.4 7940.0 8243.8 8269.8 8273.5 1157.6 1183.5 1205.8 1216.5 1237.2 6264.3 6295.8 6318.3 6341.4 6393.6 9891.6 10232.6 10391.0 10391.2 10394.2 10209.7 10265.0 10461.4 10461.6 10463.1 7781.5 7784.7 7879.3 7881.8 7888.4 7791.7 7838.5 7842.4 7843.2 7971.4 8504.8 8694.4 8975.5 9091.6 9230.8 8717.1 8949.1 9138.6 9163.5 9206.4 6661.8 6868.7 7161.9 7342.4 7446.9 7747.7 7776.2 7796.8 7816.7 7852.9 7441.7 7555.6 7624.4 7726.1 7731.3 7444.9 7480.8 7533.9 7624.5 7637.4 7714.7 7716.0 7758.7 7764.0 7768.5 7026.1 7054.8 7097.6 7107.9 7169.6 6941.1 6971.4 7244.1 7247.8 7294.4 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | [#4] prototype.html Cycles:180 Average:5380.41 Median:6085.48 stddev:1585.48 (26.1%) stddev-sans-first:1544.40 23:48:44 INFO - PROCESS | 8360 | Values: 354.9 358.8 360.6 360.8 361.0 5891.4 6020.1 6057.0 6063.6 6107.3 5783.9 5962.1 5964.6 5985.4 6003.5 4678.5 4680.7 4682.7 4688.7 4688.8 4516.6 4566.7 4602.6 4644.0 4689.6 4585.3 4611.6 4627.5 4629.7 4643.0 4641.2 4646.7 4647.2 4650.6 4659.8 4115.1 4115.7 4132.0 4143.4 4143.6 5610.6 5705.4 5715.9 5719.7 5721.5 5342.8 5407.4 5409.6 5418.6 5420.1 6055.6 6325.1 6341.6 6341.9 6345.9 4389.1 4478.9 4556.5 4570.9 4582.1 6522.2 6622.5 6627.7 6627.8 6630.3 4706.2 4708.0 4708.0 4713.6 4713.6 4699.2 4767.3 4797.4 4800.0 4824.0 5431.3 5437.1 5439.3 5452.1 5454.9 6373.6 6388.6 6417.3 6417.9 6422.6 1660.9 1676.0 1677.0 1677.7 1704.7 1177.2 1180.9 1187.5 1194.7 1195.5 6195.2 6199.5 6215.2 6217.3 6219.8 6547.0 6553.5 6554.3 6554.7 6560.1 6048.8 6207.9 6208.5 6217.7 6218.9 3517.9 3543.5 3548.2 3548.7 3549.0 6760.3 6768.3 6769.7 6798.1 6798.5 6644.9 6810.6 6811.0 6812.1 6812.5 6775.8 6779.3 6788.0 6789.3 6794.8 6337.7 6493.4 6498.6 6628.4 6643.5 6504.4 6512.9 6520.2 6537.7 6540.7 6731.4 6740.8 6741.1 6762.7 6776.5 4561.8 4641.7 4697.1 4698.0 4705.4 6640.1 6640.9 6641.4 6647.1 6647.2 6462.6 6482.3 6482.3 6482.9 6486.5 6320.8 6392.7 6454.0 6457.0 6474.5 6308.9 6366.0 6366.3 6369.2 6373.8 6441.0 6486.1 6488.6 6488.8 6491.2 6233.4 6336.7 6343.8 6344.0 6350.0 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - PROCESS | 8360 | [#5] yui.html Cycles:180 Average:14606.39 Median:25668.77 stddev:16328.88 (63.6%) stddev-sans-first:16341.87 23:48:44 INFO - PROCESS | 8360 | Values: 822.4 919.9 926.7 937.6 943.9 13584.3 13732.5 13806.1 13831.1 13840.0 12253.1 13433.5 13483.3 13509.7 13513.2 733.6 841.8 842.1 844.7 872.0 833.2 833.2 833.9 834.4 879.6 770.2 774.1 876.5 879.8 925.1 862.1 862.6 863.6 869.0 897.2 637.5 638.5 638.5 654.7 681.4 13589.0 14132.6 14140.9 14175.8 14191.6 13080.1 13608.6 14350.6 14535.7 14552.1 11183.0 11206.3 11330.7 11466.3 11495.0 3877.5 3920.3 3942.8 3944.1 3998.5 51066.2 51221.5 53187.5 53243.7 53504.5 10999.0 11032.2 11136.1 11165.3 11370.7 20540.6 20592.4 20614.8 20622.2 20630.8 7879.8 7906.1 7936.8 7943.2 8044.8 4433.0 4469.1 4529.7 4578.1 4646.2 3168.0 3195.7 3197.8 3206.0 3210.6 586.4 597.0 603.2 603.3 613.2 690.2 710.5 712.6 713.7 745.8 9097.6 9381.2 9432.9 9551.9 9667.6 614.9 639.2 655.8 673.7 682.6 4241.1 4731.6 4737.1 4789.3 4824.0 54775.7 55663.0 55810.7 60894.7 61684.7 46944.2 47526.8 48178.5 48285.0 48668.5 46691.3 48580.5 49210.5 49492.3 50096.2 9241.2 9367.9 9427.5 9526.1 9555.4 34932.0 35070.5 35671.5 39042.2 39240.6 46883.3 47399.8 47632.8 48046.5 48184.0 12687.9 12974.5 13023.8 13130.6 13253.2 13822.9 13849.5 14020.7 14064.9 14071.3 11628.9 11685.0 12645.3 13081.6 13181.5 11859.1 11928.3 12234.4 12437.9 12630.5 12598.4 12695.3 12764.8 12798.2 12949.3 10771.3 10781.0 10959.8 11093.3 11184.4 10756.7 10902.3 10905.3 11017.4 11030.7 23:48:44 INFO - PROCESS | 8360 | -------- Summary: end -------- 23:48:44 INFO - PROCESS | 8360 | 23:48:44 INFO - TEST-INFO | 8360: exit 0 23:48:44 INFO - TEST-OK | dromaeo_css | took 1110201ms 23:48:44 INFO - TEST-START | kraken 23:48:44 INFO - operating with platform_type : linux_ 23:48:44 INFO - Initialising browser for kraken test... 23:48:44 INFO - TEST-INFO | started process 8558 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpodsM2y/profile http://localhost:58955/getInfo.html) 23:48:48 INFO - PROCESS | 8558 | __metrics Screen width/height:1600/1200 23:48:48 INFO - PROCESS | 8558 | colorDepth:24 23:48:48 INFO - PROCESS | 8558 | Browser inner width/height: 1024/697 23:48:48 INFO - PROCESS | 8558 | __metrics 23:48:48 INFO - PROCESS | 8558 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:48:49 INFO - TEST-INFO | 8558: exit 0 23:48:49 INFO - Browser initialized. 23:48:49 INFO - Running cycle 1/1 for kraken test... 23:48:49 INFO - TEST-INFO | started process 8649 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpodsM2y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:01 INFO - PROCESS | 8649 | RSS: Main: 137433088 23:49:01 INFO - PROCESS | 8649 | 23:49:03 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:04 INFO - PROCESS | 8649 | RSS: Main: 172593152 23:49:04 INFO - PROCESS | 8649 | 23:49:07 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-dft) 23:49:07 INFO - PROCESS | 8649 | RSS: Main: 168951808 23:49:07 INFO - PROCESS | 8649 | 23:49:10 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-fft) 23:49:11 INFO - PROCESS | 8649 | RSS: Main: 167538688 23:49:11 INFO - PROCESS | 8649 | 23:49:13 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58955/tests/kraken/driver.html?testName=audio-oscillator) 23:49:13 INFO - PROCESS | 8649 | RSS: Main: 167641088 23:49:13 INFO - PROCESS | 8649 | 23:49:15 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:49:16 INFO - PROCESS | 8649 | RSS: Main: 166027264 23:49:16 INFO - PROCESS | 8649 | 23:49:19 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-darkroom) 23:49:19 INFO - PROCESS | 8649 | RSS: Main: 166535168 23:49:19 INFO - PROCESS | 8649 | 23:49:23 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58955/tests/kraken/driver.html?testName=imaging-desaturate) 23:49:23 INFO - PROCESS | 8649 | RSS: Main: 167337984 23:49:23 INFO - PROCESS | 8649 | 23:49:26 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58955/tests/kraken/driver.html?testName=json-parse-financial) 23:49:26 INFO - PROCESS | 8649 | RSS: Main: 167022592 23:49:26 INFO - PROCESS | 8649 | 23:49:28 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:49:29 INFO - PROCESS | 8649 | RSS: Main: 175489024 23:49:29 INFO - PROCESS | 8649 | 23:49:30 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:49:31 INFO - PROCESS | 8649 | RSS: Main: 172781568 23:49:31 INFO - PROCESS | 8649 | 23:49:33 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:49:34 INFO - PROCESS | 8649 | RSS: Main: 178163712 23:49:34 INFO - PROCESS | 8649 | 23:49:36 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:49:36 INFO - PROCESS | 8649 | RSS: Main: 178663424 23:49:36 INFO - PROCESS | 8649 | 23:49:39 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:49:39 INFO - PROCESS | 8649 | RSS: Main: 178188288 23:49:39 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | Cycle 1(1): loaded http://localhost:58955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58955/tests/kraken/driver.html?testName=ai-astar) 23:49:41 INFO - PROCESS | 8649 | RSS: Main: 238149632 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | __start_tp_report 23:49:41 INFO - PROCESS | 8649 | _x_x_mozilla_page_load 23:49:41 INFO - PROCESS | 8649 | _x_x_mozilla_page_load_details 23:49:41 INFO - PROCESS | 8649 | |i|pagename|runs| 23:49:41 INFO - PROCESS | 8649 | |0;ai-astar;109;110;103;108;108;108;100;111;109;109 23:49:41 INFO - PROCESS | 8649 | |1;audio-beat-detection;157;130;146;166;131;149;149;134;180;126 23:49:41 INFO - PROCESS | 8649 | |2;audio-dft;160;161;162;161;159;160;161;164;160;161 23:49:41 INFO - PROCESS | 8649 | |3;audio-fft;72;72;75;152;74;77;76;76;141;76 23:49:41 INFO - PROCESS | 8649 | |4;audio-oscillator;95;95;140;95;95;94;136;94;95;137 23:49:41 INFO - PROCESS | 8649 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 23:49:41 INFO - PROCESS | 8649 | |6;imaging-darkroom;147;147;146;145;146;146;146;145;145;146 23:49:41 INFO - PROCESS | 8649 | |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 23:49:41 INFO - PROCESS | 8649 | |8;json-parse-financial;54;56;57;56;55;56;57;57;58;54 23:49:41 INFO - PROCESS | 8649 | |9;json-stringify-tinderbox;66;65;65;66;66;65;65;67;66;67 23:49:41 INFO - PROCESS | 8649 | |10;stanford-crypto-aes;77;78;79;78;80;79;78;79;87;79 23:49:41 INFO - PROCESS | 8649 | |11;stanford-crypto-ccm;111;109;121;108;108;109;110;110;111;110 23:49:41 INFO - PROCESS | 8649 | |12;stanford-crypto-pbkdf2;138;137;136;137;149;126;129;140;137;138 23:49:41 INFO - PROCESS | 8649 | |13;stanford-crypto-sha256-iterative;66;65;65;65;64;64;64;68;64;64 23:49:41 INFO - PROCESS | 8649 | __end_tp_report 23:49:41 INFO - PROCESS | 8649 | __start_cc_report 23:49:41 INFO - PROCESS | 8649 | _x_x_mozilla_cycle_collect,902 23:49:41 INFO - PROCESS | 8649 | __end_cc_report 23:49:41 INFO - PROCESS | 8649 | __startTimestamp1460011781823__endTimestamp 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | ------- Summary: start ------- 23:49:41 INFO - PROCESS | 8649 | Number of tests: 14 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:3.37 (3.1%) stddev-sans-first:3.54 23:49:41 INFO - PROCESS | 8649 | Values: 109.0 110.0 103.0 108.0 108.0 108.0 100.0 111.0 109.0 109.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:149.00 stddev:17.36 (11.7%) stddev-sans-first:18.02 23:49:41 INFO - PROCESS | 8649 | Values: 157.0 130.0 146.0 166.0 131.0 149.0 149.0 134.0 180.0 126.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 23:49:41 INFO - PROCESS | 8649 | Values: 160.0 161.0 162.0 161.0 159.0 160.0 161.0 164.0 160.0 161.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.50 stddev:30.41 (40.3%) stddev-sans-first:31.62 23:49:41 INFO - PROCESS | 8649 | Values: 72.0 72.0 75.0 152.0 74.0 77.0 76.0 76.0 141.0 76.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:95.00 stddev:20.77 (21.9%) stddev-sans-first:21.53 23:49:41 INFO - PROCESS | 8649 | Values: 95.0 95.0 140.0 95.0 95.0 94.0 136.0 94.0 95.0 137.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:49:41 INFO - PROCESS | 8649 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 23:49:41 INFO - PROCESS | 8649 | Values: 147.0 147.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:49:41 INFO - PROCESS | 8649 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.33 (2.4%) stddev-sans-first:1.20 23:49:41 INFO - PROCESS | 8649 | Values: 54.0 56.0 57.0 56.0 55.0 56.0 57.0 57.0 58.0 54.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 23:49:41 INFO - PROCESS | 8649 | Values: 66.0 65.0 65.0 66.0 66.0 65.0 65.0 67.0 66.0 67.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.80 (3.5%) stddev-sans-first:2.83 23:49:41 INFO - PROCESS | 8649 | Values: 77.0 78.0 79.0 78.0 80.0 79.0 78.0 79.0 87.0 79.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#11] stanford-crypto-ccm Cycles:10 Average:110.70 Median:110.00 stddev:3.77 (3.4%) stddev-sans-first:4.00 23:49:41 INFO - PROCESS | 8649 | Values: 111.0 109.0 121.0 108.0 108.0 109.0 110.0 110.0 111.0 110.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.70 Median:137.50 stddev:6.15 (4.5%) stddev-sans-first:6.50 23:49:41 INFO - PROCESS | 8649 | Values: 138.0 137.0 136.0 137.0 149.0 126.0 129.0 140.0 137.0 138.0 23:49:41 INFO - PROCESS | 8649 | 23:49:41 INFO - PROCESS | 8649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 23:49:41 INFO - PROCESS | 8649 | Values: 66.0 65.0 65.0 65.0 64.0 64.0 64.0 68.0 64.0 64.0 23:49:41 INFO - PROCESS | 8649 | -------- Summary: end -------- 23:49:41 INFO - PROCESS | 8649 | 23:49:42 INFO - TEST-INFO | 8649: exit 0 23:49:42 INFO - TEST-OK | kraken | took 57822ms 23:49:42 INFO - TEST-START | v8_7 23:49:42 INFO - operating with platform_type : linux_ 23:49:42 INFO - Initialising browser for v8_7 test... 23:49:42 INFO - TEST-INFO | started process 8904 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeX9xET/profile http://localhost:58955/getInfo.html) 23:49:46 INFO - PROCESS | 8904 | __metrics Screen width/height:1600/1200 23:49:46 INFO - PROCESS | 8904 | colorDepth:24 23:49:46 INFO - PROCESS | 8904 | Browser inner width/height: 1024/697 23:49:46 INFO - PROCESS | 8904 | __metrics 23:49:46 INFO - PROCESS | 8904 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:49:47 INFO - TEST-INFO | 8904: exit 0 23:49:47 INFO - Browser initialized. 23:49:47 INFO - Running cycle 1/1 for v8_7 test... 23:49:47 INFO - TEST-INFO | started process 8992 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeX9xET/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:59 INFO - PROCESS | 8992 | RSS: Main: 138637312 23:49:59 INFO - PROCESS | 8992 | 23:50:21 INFO - PROCESS | 8992 | Cycle 1(1): loaded http://localhost:58955/tests/v8_7/run.html (next: http://localhost:58955/tests/v8_7/run.html) 23:50:22 INFO - PROCESS | 8992 | RSS: Main: 416862208 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | __start_tp_report 23:50:22 INFO - PROCESS | 8992 | _x_x_mozilla_page_load 23:50:22 INFO - PROCESS | 8992 | _x_x_mozilla_page_load_details 23:50:22 INFO - PROCESS | 8992 | |i|pagename|runs| 23:50:22 INFO - PROCESS | 8992 | |0;Richards;165.89250165892503 23:50:22 INFO - PROCESS | 8992 | |1;DeltaBlue;168.66250632484397 23:50:22 INFO - PROCESS | 8992 | |2;Encrypt;278.55153203342616 23:50:22 INFO - PROCESS | 8992 | |3;Decrypt;5170.103092783505 23:50:22 INFO - PROCESS | 8992 | |4;RayTrace;951.4747859181732 23:50:22 INFO - PROCESS | 8992 | |5;Earley;556.7928730512249 23:50:22 INFO - PROCESS | 8992 | |6;Boyer;10702.127659574468 23:50:22 INFO - PROCESS | 8992 | |7;RegExp;40480 23:50:22 INFO - PROCESS | 8992 | |8;Splay;504.74762618690653 23:50:22 INFO - PROCESS | 8992 | |9;NavierStokes;4822.115384615385 23:50:22 INFO - PROCESS | 8992 | __end_tp_report 23:50:22 INFO - PROCESS | 8992 | __startTimestamp1460011822066__endTimestamp 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | ------- Summary: start ------- 23:50:22 INFO - PROCESS | 8992 | Number of tests: 10 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 165.9 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#1] DeltaBlue Cycles:1 Average:168.66 Median:168.66 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 168.7 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 278.6 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 5170.1 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#4] RayTrace Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 951.5 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#5] Earley Cycles:1 Average:556.79 Median:556.79 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 556.8 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#6] Boyer Cycles:1 Average:10702.13 Median:10702.13 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 10702.1 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#7] RegExp Cycles:1 Average:40480.00 Median:40480.00 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 40480.0 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#8] Splay Cycles:1 Average:504.75 Median:504.75 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 504.7 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - PROCESS | 8992 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 23:50:22 INFO - PROCESS | 8992 | Values: 4822.1 23:50:22 INFO - PROCESS | 8992 | -------- Summary: end -------- 23:50:22 INFO - PROCESS | 8992 | 23:50:22 INFO - TEST-INFO | 8992: exit 0 23:50:22 INFO - TEST-OK | v8_7 | took 40199ms 23:50:22 INFO - SUITE-END | took 1208s 23:50:23 INFO - Completed test suite (00:20:08) 23:50:23 INFO - Working with test: dromaeo_css 23:50:23 INFO - Generating results file: dromaeo_css 23:50:23 INFO - Working with test: kraken 23:50:23 INFO - Generating results file: kraken 23:50:23 INFO - javascript benchmark 23:50:23 INFO - Working with test: v8_7 23:50:23 INFO - Generating results file: v8_7 23:50:23 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:50:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 23:50:23 INFO - process_Request line: dromaeo_css 7289.68 graph.html#tests=[[72,53,35]] 23:50:23 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:50:23 INFO - process_Request line: kraken 1475.90 graph.html#tests=[[232,53,35]] 23:50:23 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:50:23 INFO - process_Request line: v8_7 22121.35 graph.html#tests=[[230,53,35]] 23:50:23 INFO - RETURN: dromaeo_css: 7289.68 23:50:23 INFO - RETURN: kraken: 1475.90 23:50:23 INFO - RETURN: v8_7: 22121.35 23:50:23 INFO - javascript benchmark 23:50:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3229.5640088588043, 3285.2608163163277, 3315.5524004259432, 3324.285278665088, 3344.71569916557, 5249.92125118123, 5275.498827611375, 5276.0, 5297.284866543016, 5298.814541491049, 5295.8146464873735, 5310.946890531093, 5314.867128321794, 5327.520523152915, 5336.252924590561, 4830.347903033098, 4837.0567739290855, 4851.902961940767, 4874.65877388583, 4896.069746748124, 4864.124457597631, 4877.122118018755, 4931.80272789088, 4937.210046392578, 4939.036887806879, 4793.90412191756, 4860.295257187706, 4890.364252647151, 4905.068037072945, 4936.7037977721275, 4878.609711223111, 4895.6083513318845, 4898.583620392271, 4900.558949694509, 4930.556249937487, 4749.4775574686755, 4810.206315957863, 4849.927251091236, 4872.171730805771, 4879.414470263591, 5123.7438128093445, 5197.66215196011, 5239.607029472805, 5244.763985620656, 5270.92093618596, 5556.083246264361, 5635.830925072254, 5639.351474580394, 5645.887082258332, 5646.096624540054, 5534.806281780158, 5604.159376093618, 5692.37383887772, 5695.316562012585, 5697.914531282034, 5343.385510666284, 5374.946250537523, 5402.243685883979, 5404.756785944642, 5427.810026649087, 5833.620814647034, 5867.73595188209, 5869.442402971797, 5870.295564532284, 5877.059670452707, 5517.393086760533, 5579.38626751057, 5629.437056294338, 5629.943700562942, 5654.095344744821, 5726.284214473191, 5729.25519682447, 5733.054046082433, 5739.540836733051, 5740.397258287903, 5677.971610141923, 5679.2333035040565, 5682.488576028178, 5682.886342273131, 5683.687397193194, 5591.41290164535, 5620.606557541015, 5635.6618602883955, 5656.066748986371, 5681.34664513578, 4401.845935392246, 4411.647068234598, 4413.3821265022925, 4417.116576684676, 4438.045820148684, 3963.8216280267457, 3970.06703424695, 3990.780507072081, 4015.738976966488, 4023.0746928206677, 5306.416294207634, 5321.148616221386, 5386.218998245233, 5399.622026458111, 5489.945100549024, 5761.88476230473, 5765.94234057654, 5772.480476757112, 5799.0, 5801.419858014165, 5433.510984011379, 5465.890682186334, 5467.535259502987, 5467.890642187134, 5473.233747275384, 4847.030593881238, 4914.287428322945, 4991.176455884811, 5025.0, 5083.644144909821, 5805.071188609802, 5805.274340707411, 5807.593468457252, 5817.88364232713, 5826.359100498942, 5689.971550142222, 5692.7722891083895, 5693.0, 5697.059985102412, 5714.5999780015, 5633.521150702072, 5777.133429985536, 5832.708364581838, 5873.50075243592, 5924.52603791687, 5623.437656234344, 5648.181013753065, 5667.914981275202, 5669.943300567106, 5672.064109422065, 5557.249771280825, 5730.856728581819, 5733.0, 5736.254286942671, 5737.74180161902, 5409.269748583891, 5628.380878103487, 5695.800646977502, 5702.087665973424, 5726.74229659658, 5534.308211473566, 5535.280413546374, 5537.0, 5538.335399752055, 5542.0855558832345, 5327.600429967845, 5455.427180146027, 5477.561795056306, 5481.287432633732, 5508.91736623943, 5552.444755524577, 5635.0702134147405, 5650.802221922213, 5656.321241451053, 5661.915071274017, 5541.473560011793, 5573.414791446839, 5575.080111781673, 5580.162975553537, 5582.162675598693], "unit": "score", "name": "dojo.html", "value": 5273.89470750288}, {"lowerIsBetter": false, "replicates": [515.9071367153911, 549.1049589169653, 574.744238813728, 574.8646423313953, 577.6765011593508, 30913.22716932075, 38857.0, 38870.0, 38937.22125557487, 38951.80524097382, 43147.568524314745, 43311.0, 43346.34980475288, 43465.0, 43652.0, 8622.267107295871, 8907.599158037872, 8909.420887642314, 8927.330450216226, 8940.10598940104, 8668.089850565695, 8802.427842190269, 8811.295096392305, 8814.86777698335, 8825.558722063903, 8823.382363234545, 8859.955700221522, 8862.778430539223, 8878.778030549223, 8893.199612034916, 8680.782980425509, 8788.560571971408, 8792.07683193265, 8803.29573634114, 8805.0, 8785.7803554911, 8844.823103537894, 8902.688405905763, 8915.821683566357, 8918.554072296423, 42440.36339454911, 42934.0, 43084.78457607723, 43098.78450607758, 43193.13613727739, 3644.817759112034, 3751.306008388457, 3780.6030366811365, 4078.5921407859273, 4349.69552131351, 32688.0, 32859.50710739317, 32891.0, 32975.175620609436, 33384.16539586506, 4237.4915010198665, 4282.700210985232, 4292.29177185764, 4335.436393268887, 4393.978030109861, 290589.0, 290857.0, 291434.0, 291792.0, 292518.0, 57944.13083803746, 59483.0, 63452.36547634557, 72930.0, 74845.0, 58866.41133588609, 59120.40879591235, 59152.40847591555, 59152.7042364794, 59210.70394647999, 17687.469375918743, 17823.910880445514, 17875.553111172063, 17885.19516621729, 17899.73150402745, 14181.078229915023, 14262.500812471513, 14278.214698191492, 14284.928575357057, 14562.85437145615, 21436.249731259642, 21985.450363741034, 21989.0, 21994.560108797734, 22073.668894966588, 7599.658015389321, 7831.0, 7873.881891771628, 7945.260213764928, 7947.324477419368, 986.4820968991194, 1021.5760459409262, 1046.4610725476387, 1061.5806756331206, 1063.9574417023232, 29625.85187074094, 29626.703732962393, 33102.0, 33240.335193296, 33392.0, 1122.8764835868049, 1130.2088538023415, 1136.613551392514, 1191.4162060590422, 1208.275034979023, 13772.098061233648, 14701.18947614339, 14803.925980370244, 15644.374225031099, 15843.207839607974, 437560.0, 438413.0, 438591.0, 439264.0, 444640.0, 56968.715156423954, 57533.0, 57629.0, 57638.7118064407, 57702.7114864423, 1457.7521821290406, 1474.8303945046457, 1480.7852861335261, 1485.6434455730764, 1501.527018989015, 31696.683033169375, 31932.680673192972, 32000.5199922006, 32351.35297294088, 32604.021879343658, 47100.58698239058, 47793.0, 52131.739341304565, 52692.0, 52780.0, 310657.0, 314642.0, 314897.0, 316157.0, 316719.0, 44670.553294467936, 45148.0, 45464.77267613641, 45500.0, 46440.767796160806, 47804.2829357553, 48143.27785083157, 48332.51667483421, 48744.0, 49323.0, 40477.79761101176, 41644.79177604214, 41718.16563668649, 42141.0, 43082.0, 41143.0, 41553.37669935014, 41605.58394416017, 41875.7906210467, 42064.1587168261, 40871.1825763489, 40938.79530602447, 41187.588124118374, 41594.1681166381, 41968.370474443516, 31883.521747174276, 33108.337833243684, 37277.81361093177, 37444.62555374411, 39629.0, 25256.989720410977, 27651.0, 27951.021714239905, 28036.85981570079, 28039.439211215253], "unit": "score", "name": "ext.html", "value": 20198.57632187811}, {"lowerIsBetter": false, "replicates": [368.6866163760802, 373.6543697080201, 377.52997518089984, 385.52387801065686, 388.9630485103916, 14498.13011219325, 15887.44393946212, 17103.82896171038, 19057.142428590712, 19146.42560723177, 17300.096989331163, 17842.19710113045, 17880.64238715225, 17918.19368128434, 18078.0, 4331.891702707426, 5579.609427340088, 5750.654960702372, 5778.133280007991, 5778.884422311551, 4403.229434848905, 5974.133750606159, 6204.162438070848, 6238.688065596724, 6241.687915604224, 6148.200733904586, 6225.284092329395, 6310.368963103699, 6313.77901773438, 6337.239531256233, 5130.153524668425, 5329.653572517774, 6224.159738435299, 6241.968790156043, 6289.842753931142, 5086.872828179288, 5136.820211292624, 5156.484351564851, 5162.638615296931, 5170.405403378622, 12453.875461245361, 12506.249625022438, 12556.121071524996, 12610.747785044248, 18614.813851861443, 745.8993035940188, 746.2649290448903, 746.4215233194263, 2077.98961005194, 2398.806583746205, 10829.336530775427, 13577.049606527547, 13920.443182272798, 13982.300884955712, 14167.929160354235, 1887.5847313591125, 1892.6971684530408, 1982.9107690153978, 2006.7491563554556, 2013.4563667809755, 66154.0, 66456.66771666158, 66821.33178668248, 67282.3271767281, 67887.32112678909, 16014.919925400298, 16056.43802466908, 16115.355385784671, 16204.513864584082, 16269.10519921392, 25403.491930161665, 25610.231693049238, 25915.0, 25943.351416214744, 26048.609270860954, 7814.296713295717, 8007.1592482788465, 8024.0772311184965, 8039.799005024921, 8095.23095305945, 8101.392395570356, 8117.431779775359, 8173.223543763333, 8174.059983101901, 8287.171282871665, 4222.852200172979, 4353.978230108829, 4394.252976993918, 4499.0, 4559.247724125482, 1833.8624603154817, 1853.5458812591, 1865.2632210276865, 1900.4393703857395, 1916.0802814648769, 918.8897332320164, 954.9236061115095, 1093.9343639381664, 1109.7281166114353, 1123.118352093619, 14891.255437228096, 15073.397064117531, 16482.917585411997, 16743.91628041852, 17319.653606928045, 994.8408254679216, 1007.9596816127273, 1032.2747945424087, 1034.4672493665769, 1123.466353482106, 9152.72541823733, 9527.237820974444, 9821.508924553744, 10355.43045132525, 10363.430011349297, 446632.0, 448864.0, 451562.0, 454958.0, 669874.0, 64081.679591602675, 80872.59563702262, 81868.0, 84650.57674711588, 85832.57083714541, 1098.593520397458, 1141.149843366697, 1196.6589521986193, 1218.500414829933, 1228.582282024116, 14680.0, 14959.626009349853, 15248.466303679761, 15275.541733748005, 15492.767608485656, 31971.721131155424, 32034.519482208252, 32114.0, 32934.99999999904, 35515.46726799152, 41418.58581414147, 42938.35592466178, 43369.78315108404, 45974.310385343575, 46832.0, 7222.855542889008, 7248.202697703354, 7349.118105827335, 7490.70037198506, 7802.297793198412, 10913.39976301311, 11130.443477826238, 11418.543258269909, 11643.88356116428, 11935.641930742091, 10133.03736145065, 10136.290459668047, 10291.22815788804, 10613.9469302653, 10622.415767132881, 9864.0, 9930.354526955725, 10211.693649190536, 10429.3687852561, 10509.106725928381, 10179.338343007681, 10480.475976201313, 10705.19711021661, 10817.56729730802, 10957.890421096006, 7577.5453472791805, 7731.7680469586, 7812.335951444191, 7828.099768526465, 7881.724139655084, 9171.908280917105, 9850.852237216592, 10774.515146818256, 10997.560097596006, 11026.44867756625], "unit": "score", "name": "jquery.html", "value": 8699.847322818778}, {"lowerIsBetter": false, "replicates": [1389.8332200135985, 1539.038101186758, 1558.9610259743508, 1781.7149256119023, 1894.2328357015413, 7520.623968801566, 8160.306373958213, 8348.081711011791, 8367.958160209191, 8368.58157092146, 8197.549134797584, 8394.748157555268, 8410.285125764318, 8414.873776893337, 8418.200270974263, 2462.1136390899305, 2480.8635525046116, 2488.5645012122895, 2489.0914816092177, 2490.4272017436, 2358.6226203807396, 2429.79346755526, 2430.9392265193424, 2431.732509423962, 2443.926682199537, 2421.406755344943, 2426.708794944609, 2481.6153496208117, 2494.3140636325065, 2510.422602801357, 2429.9028038878514, 2437.305367970129, 2437.683101196842, 2523.1421316752394, 2524.432002799374, 2458.409981604402, 2479.82641215115, 2488.14159115105, 2489.3278814720106, 2514.5473814713528, 8472.237498625153, 8511.787205319855, 8516.361272904556, 8519.361047921431, 8523.659053637846, 5161.948380516184, 5295.338082739658, 5304.469553044703, 5314.548263397616, 5315.362156541201, 3335.166208447888, 3364.6467120952193, 3375.71306438953, 3407.7103446206856, 3421.9486707699402, 1069.1500257295468, 1078.3044936016227, 1080.4597701149426, 1092.8797832238447, 1098.1653943003296, 11859.347735874524, 11875.287482750977, 11894.0, 11944.820827687505, 11946.522139114424, 4664.673472856867, 4684.812607495662, 4734.337192793012, 4744.7627618618935, 4802.615790736732, 10075.143612792848, 10077.949610252048, 10079.69760907174, 10093.69718908434, 10108.342957707726, 5294.602904782079, 5326.627136100436, 5331.626786125012, 5334.5732341412595, 5338.279332290091, 4218.78906054696, 4361.433013708261, 4361.454818147731, 4624.630029597692, 4863.221884498464, 4035.3139966205817, 4052.0, 4065.2479291331197, 4103.958960410358, 4108.322126849036, 1326.2374134872487, 1339.2232505146992, 1343.8857697095661, 1351.2568087551808, 1356.572679605921, 1410.8871290296752, 1449.282605110456, 1461.6492041909864, 1463.6194589406618, 1474.292339676961, 7831.373490120891, 7940.0, 8243.793905152299, 8269.751907442665, 8273.46222495548, 1157.6064138193055, 1183.47335435732, 1205.8432403787451, 1216.4829947272374, 1237.2329155923205, 6264.279607845065, 6295.842603934938, 6318.273398559132, 6341.397567231105, 6393.584417012879, 9891.554880030415, 10232.6418575351, 10391.012853778879, 10391.220658450646, 10394.16846652266, 10209.744756381002, 10265.0, 10461.424621645883, 10461.633842815465, 10463.110635595907, 7781.5331080135375, 7784.688612455551, 7879.33025692811, 7881.802954926058, 7888.447808653339, 7791.727289544839, 7838.490498117604, 7842.372610191057, 7843.176466470938, 7971.402144839044, 8504.787380315542, 8694.434861733967, 8975.50634715097, 9091.590878410356, 9230.78461169328, 8717.084706105768, 8949.105089490999, 9138.634454622006, 9163.541822908961, 9206.447613143233, 6661.833454163685, 6868.690908909211, 7161.856762864818, 7342.449316301406, 7446.851062978819, 7747.72882949094, 7776.183500732342, 7796.766097017098, 7816.687332506636, 7852.882206766789, 7441.739539116105, 7555.622218888923, 7624.390048795972, 7726.1114971776715, 7731.265529774662, 7444.888326675213, 7480.812979675552, 7533.886991695019, 7624.5425274483705, 7637.389008879165, 7714.652840622073, 7716.0, 7758.728444504415, 7764.0, 7768.456208065381, 7026.1217347831525, 7054.788356349318, 7097.574145551283, 7107.857842843217, 7169.641517924188, 6941.062956500808, 6971.372576468142, 7244.094488188976, 7247.782566523013, 7294.379977701955], "unit": "score", "name": "mootools.html", "value": 4904.804264136618}, {"lowerIsBetter": false, "replicates": [354.88643634037106, 358.7650089191577, 360.59793330436565, 360.80877135118396, 360.97292703047276, 5891.410858914106, 6020.0668896321085, 6057.030875059997, 6063.636181829088, 6107.328193898667, 5783.913241301373, 5962.135490353896, 5964.552658550615, 5985.431384018511, 6003.459688628022, 4678.485366609671, 4680.719156850591, 4682.719036857782, 4688.742119183444, 4688.765561721917, 4516.593506584407, 4566.6575006874455, 4602.562756538124, 4644.024754801496, 4689.554492323224, 4585.2892801615635, 4611.5619016193405, 4627.467841198271, 4629.6759226853965, 4643.0, 4641.164590373748, 4646.721196728207, 4647.209974304376, 4650.604698600623, 4659.78845500169, 4115.135821477494, 4115.670746340285, 4132.0, 4143.357779544175, 4143.647789937859, 5610.635308704962, 5705.4294570543025, 5715.885682286373, 5719.656820590778, 5721.4564616361795, 5342.759575819058, 5407.3781515125875, 5409.648372855791, 5418.620696551243, 5420.13277875538, 6055.576109672281, 6325.0828629848875, 6341.636548142172, 6341.936580634181, 6345.9365406345805, 4389.078293558325, 4478.910421791546, 4556.498785133633, 4570.88572785683, 4582.1293954148605, 6522.184726909137, 6622.53642245043, 6627.73489060437, 6627.80116596498, 6630.303818099078, 4706.176419126639, 4707.95292047082, 4707.95292047082, 4713.57577817998, 4713.599344055794, 4699.201135806921, 4767.332573439721, 4797.40032495938, 4800.015996720664, 4823.9517604824205, 5431.266778984866, 5437.13005919051, 5439.292891924104, 5452.127659574449, 5454.8909021819345, 6373.649449280241, 6388.648624325614, 6417.294097649255, 6417.871642567123, 6422.550421470452, 1660.892042017265, 1675.9832401675826, 1677.0, 1677.689627418907, 1704.7357659562788, 1177.1583317927723, 1180.9291442513477, 1187.5427960235372, 1194.6595220362155, 1195.5038658956435, 6195.2255968004, 6199.504039676815, 6215.223097112861, 6217.253929528395, 6219.813405597839, 6546.967265163644, 6553.508486863504, 6554.3445655435025, 6554.737810487527, 6560.147180866456, 6048.848778780566, 6207.875842483216, 6208.4722798561725, 6217.6891155442045, 6218.9378106219265, 3517.9120521987156, 3543.4684797280097, 3548.2193917338145, 3548.6628770266784, 3549.0, 6760.290169532227, 6768.289329620417, 6769.72921083161, 6798.082258895085, 6798.490113241527, 6644.870372036766, 6810.6254156020905, 6810.965945170243, 6812.114425124702, 6812.4550035997, 6775.830604234933, 6779.3220677932795, 6787.966060169766, 6789.2871248518195, 6794.796156115324, 6337.7148028337915, 6493.383128602775, 6498.610083395011, 6628.436582890508, 6643.468522518284, 6504.38208370204, 6512.934870651422, 6520.217573891164, 6537.738490460329, 6540.705668245036, 6731.360520750521, 6740.764073257413, 6741.089952856301, 6762.695678694372, 6776.525643204928, 4561.794719237576, 4641.675082744176, 4697.0840686065885, 4698.013417182293, 4705.411823522059, 6640.07039014548, 6640.867182656417, 6641.435477984232, 6647.135872336566, 6647.169103862017, 6462.579932304385, 6482.286948435574, 6482.319356467503, 6482.935170648422, 6486.513511486563, 6320.810375688737, 6392.744290228339, 6453.967730161319, 6457.0, 6474.546781725422, 6308.873822523616, 6366.0, 6366.299707032315, 6369.235691717024, 6373.840653983688, 6440.967795160994, 6486.091947127312, 6488.610683358825, 6488.837779055561, 6491.221053473613, 6233.376662333731, 6336.683165841781, 6343.809685709436, 6343.9849624059925, 6350.0], "unit": "score", "name": "prototype.html", "value": 4877.147136677131}, {"lowerIsBetter": false, "replicates": [822.3667775812623, 919.8620206968958, 926.6664000959657, 937.6343226141806, 943.9292053096019, 13584.3207839608, 13732.450701971935, 13806.102603330777, 13831.100978436407, 13840.0, 12253.081018923594, 13433.529826456075, 13483.325833708324, 13509.729805403911, 13513.189208647487, 733.5928559649392, 841.7685136587427, 842.0568962761715, 844.7127976487993, 872.0451106038877, 833.1834801894147, 833.1918039501674, 833.9374546908975, 834.3742193354984, 879.560219890055, 770.1643716567503, 774.1484367196095, 876.5222953490331, 879.8416285068685, 925.1118925831211, 862.1378621378622, 862.590269621934, 863.5595846118462, 868.9522076285801, 897.2104547997753, 637.4772686397156, 638.4668801550711, 638.4955884850962, 654.7315600603778, 681.3595220492721, 13589.0, 14132.576022719335, 14140.858591414057, 14175.78736318956, 14191.574252772434, 13080.084394092417, 13608.591742247749, 14350.569482915425, 14535.709285814224, 14552.126872387691, 11183.0, 11206.327620342723, 11330.71673208168, 11466.2546934449, 11495.0, 3877.4765406670303, 3920.313945059632, 3942.7831469269177, 3944.073142811437, 3998.52017757868, 51066.23400648993, 51221.487785122044, 53187.46812531903, 53243.73378133123, 53504.46495535034, 10999.0, 11032.172587056002, 11136.109111271078, 11165.274257173258, 11370.658880233606, 20540.589188216152, 20592.382228533166, 20614.793852061586, 20622.175112995614, 20630.793692063187, 7879.803004924923, 7906.090799558009, 7936.801579960547, 7943.205679432011, 8044.798880028046, 4433.0, 4469.083837813306, 4529.705569137996, 4578.084383123389, 4646.233371493733, 3168.0337497063156, 3195.7283630891634, 3197.76016798741, 3205.951910721341, 3210.5826242588782, 586.3696526234315, 597.0268462406336, 603.2067830802481, 603.2579926690196, 613.2487702564323, 690.2476300832117, 710.5417006031081, 712.6187489693093, 713.6503113474464, 745.7874505765939, 9097.590608422637, 9381.202597779129, 9432.90567094334, 9551.856722149174, 9667.613295468243, 614.9046897730769, 639.2424976402884, 655.8262060553957, 673.6598018000878, 682.6347903871405, 4241.130568233505, 4731.550502702306, 4737.123632128068, 4789.281607758864, 4823.975880120647, 54775.72612136914, 55663.0, 55810.72094639582, 60894.69552652297, 61684.69157654183, 46944.183348998486, 47526.76236618864, 48178.518214818105, 48285.0, 48668.51331486711, 46691.29963050557, 48580.514194858304, 49210.52368428881, 49492.25761613579, 50096.24855627168, 9241.168294853496, 9367.859482107637, 9427.481488518197, 9526.095020972996, 9555.378900371454, 34932.0, 35070.47394289139, 35671.46492802558, 39042.2191556173, 39240.60759392484, 46883.29675054945, 47399.76300118477, 47632.7618361906, 48046.5195348042, 48184.0, 12687.936560317139, 12974.545890894151, 13023.827855493051, 13130.606081817561, 13253.204807711569, 13822.93088534551, 13849.515266966011, 14020.719585608434, 14064.859351406763, 14071.296435177996, 11628.94185529067, 11685.00677442393, 12645.304508252135, 13081.607551773463, 13181.538646147723, 11859.110566707704, 11928.284302941851, 12234.388280585757, 12437.875621243671, 12630.494780209056, 12598.370081495705, 12695.301758403377, 12764.808527871903, 12798.16811907223, 12949.287789171685, 10771.299865508718, 10781.0, 10959.780804384027, 11093.278936869077, 11184.384858832842, 10756.677299681021, 10902.345859248471, 10905.34567925927, 11017.44912754375, 11030.724231894266], "unit": "score", "name": "yui.html", "value": 6768.037018190253}], "name": "dromaeo_css", "value": 7289.683872344901}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 103.0, 108.0, 108.0, 108.0, 100.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 146.0, 166.0, 131.0, 149.0, 149.0, 134.0, 180.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 161.0, 159.0, 160.0, 161.0, 164.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 152.0, 74.0, 77.0, 76.0, 76.0, 141.0, 76.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 140.0, 95.0, 95.0, 94.0, 136.0, 94.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 57.0, 56.0, 55.0, 56.0, 57.0, 57.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.8}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 78.0, 80.0, 79.0, 78.0, 79.0, 87.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 121.0, 108.0, 108.0, 109.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 110.7}, {"lowerIsBetter": true, "replicates": [138.0, 137.0, 136.0, 137.0, 149.0, 126.0, 129.0, 140.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.7}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 68.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1475.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [168.66250632484397], "unit": "score", "name": "DeltaBlue", "value": 392.01362200000005}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [951.4747859181732], "unit": "score", "name": "RayTrace", "value": 777.728439}, {"lowerIsBetter": false, "replicates": [556.7928730512249], "unit": "score", "name": "Earley", "value": 1196.967548}, {"lowerIsBetter": false, "replicates": [10702.127659574468], "unit": "score", "name": "Boyer", "value": 62.273878727634155}, {"lowerIsBetter": false, "replicates": [40480.0], "unit": "score", "name": "RegExp", "value": 22.504570158102755}, {"lowerIsBetter": false, "replicates": [504.74762618690653], "unit": "score", "name": "Splay", "value": 161.44900099009905}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22121.350409267903}]} 23:50:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22121.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1475.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7289.68"}}} 23:50:23 INFO - Return code: 0 23:50:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:50:23 INFO - # TBPL SUCCESS # 23:50:23 INFO - Running post-action listener: _resource_record_post_action 23:50:23 INFO - Running post-run listener: _resource_record_post_run 23:50:24 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463106048; Read time: 12; Write time: 406496 23:50:24 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 234991616; Read time: 0; Write time: 309552 23:50:24 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 228114432; Read time: 12; Write time: 96944 23:50:24 INFO - Running post-run listener: _upload_blobber_files 23:50:24 INFO - Blob upload gear active. 23:50:24 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:50:24 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 23:50:24 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', 'Mozilla-Beta', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:50:24 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 Mozilla-Beta -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:50:25 INFO - (blobuploader) - INFO - Open directory for files ... 23:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:25 INFO - (blobuploader) - INFO - Done attempting. 23:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:26 INFO - (blobuploader) - INFO - Done attempting. 23:50:26 INFO - (blobuploader) - INFO - Iteration through files over. 23:50:26 INFO - Return code: 0 23:50:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:50:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:50:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02789427909795069950a8d7f88005e548f3715d4e5e302268c8e7b5db934e0c1a0619d0ee7d64114830b308cd868159d0e22c002699bef2739dcf9d8c005310", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ad59553dd1c6f6ae96c9bac20259724610664f7b714b4d2475d00394666aff9dfa407ce882c6a21cea8d89284de15403b84c85d9c094712b89b35920831626c"} 23:50:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:50:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:50:26 INFO - Contents: 23:50:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02789427909795069950a8d7f88005e548f3715d4e5e302268c8e7b5db934e0c1a0619d0ee7d64114830b308cd868159d0e22c002699bef2739dcf9d8c005310", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ad59553dd1c6f6ae96c9bac20259724610664f7b714b4d2475d00394666aff9dfa407ce882c6a21cea8d89284de15403b84c85d9c094712b89b35920831626c"} 23:50:26 INFO - Running post-run listener: copy_logs_to_upload_dir 23:50:26 INFO - Copying logs to upload dir... 23:50:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:50:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.187706 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-04-06 23:50:25.920403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:25.928056) ========= 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02789427909795069950a8d7f88005e548f3715d4e5e302268c8e7b5db934e0c1a0619d0ee7d64114830b308cd868159d0e22c002699bef2739dcf9d8c005310", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ad59553dd1c6f6ae96c9bac20259724610664f7b714b4d2475d00394666aff9dfa407ce882c6a21cea8d89284de15403b84c85d9c094712b89b35920831626c"} build_url:https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/SdAC7-xCS069-fyL_uew6w/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02789427909795069950a8d7f88005e548f3715d4e5e302268c8e7b5db934e0c1a0619d0ee7d64114830b308cd868159d0e22c002699bef2739dcf9d8c005310", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ad59553dd1c6f6ae96c9bac20259724610664f7b714b4d2475d00394666aff9dfa407ce882c6a21cea8d89284de15403b84c85d9c094712b89b35920831626c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:25.952607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:25.955966) ========= 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=574dc5aafe09851ec43d388c000001b6-1460006494.850077-836975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004811 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 23:50:26.036441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 23:50:26.039804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 23:50:26.040098) ========= ========= Total master_lag: 0.34 =========