builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1450961849.1 results: success (0) buildid: 20151224023002 builduid: ee97a50b5a6f45d6ad4df6fbea594f4c revision: 1afb843f090784cb45d01a428773f4352f73a515 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.097797) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.098181) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.098527) ========= 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.131368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.131647) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.155897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.156159) ========= 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004679 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.207333) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.207609) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.208038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.208333) ========= 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 04:57:29-- 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% 60.3M=0s 2015-12-24 04:57:29 (60.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.322553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.322868) ========= 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017170 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.407452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:29.407803) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 1afb843f090784cb45d01a428773f4352f73a515 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 1afb843f090784cb45d01a428773f4352f73a515 --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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 04:57:29,822 truncating revision to first 12 chars 2015-12-24 04:57:29,822 Setting DEBUG logging. 2015-12-24 04:57:29,822 attempt 1/10 2015-12-24 04:57:29,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/1afb843f0907?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 04:57:30,325 unpacking tar archive at: b2g-inbound-1afb843f0907/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:30.222842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:30.223138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:30.235300) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:30.235591) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 04:57:30.235966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-24 04:57:30.236263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:57:30 INFO - MultiFileLogger online at 20151224 04:57:30 in /builds/slave/test-pgo 04:57:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:57:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:57:30 INFO - {'append_to_log': False, 04:57:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:57:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:57:30 INFO - 'branch': 'B2G-Inbound', 04:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:30 INFO - 'config_files': ('talos/linux_config.py',), 04:57:30 INFO - 'default_actions': ('clobber', 04:57:30 INFO - 'read-buildbot-config', 04:57:30 INFO - 'download-and-extract', 04:57:30 INFO - 'populate-webroot', 04:57:30 INFO - 'create-virtualenv', 04:57:30 INFO - 'install', 04:57:30 INFO - 'run-tests'), 04:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:30 INFO - 'download_minidump_stackwalk': True, 04:57:30 INFO - 'download_symbols': 'ondemand', 04:57:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:30 INFO - 'installer_path': 'installer.exe', 04:57:30 INFO - 'log_level': 'info', 04:57:30 INFO - 'log_name': 'talos', 04:57:30 INFO - 'log_to_console': True, 04:57:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:57:30 INFO - 'opt_config_files': (), 04:57:30 INFO - 'pip_index': False, 04:57:30 INFO - 'sps_profile': False, 04:57:30 INFO - 'sps_profile_interval': 0, 04:57:30 INFO - 'suite': 'dromaeojs', 04:57:30 INFO - 'system_bits': '64', 04:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:30 INFO - 'title': 'talos-linux64-ix-014', 04:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:30 INFO - 'use_talos_json': True, 04:57:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:30 INFO - 'work_dir': 'build'} 04:57:30 INFO - ##### 04:57:30 INFO - ##### Running clobber step. 04:57:30 INFO - ##### 04:57:30 INFO - Running pre-action listener: _resource_record_pre_action 04:57:30 INFO - Running main action method: clobber 04:57:30 INFO - rmtree: /builds/slave/test-pgo/build 04:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:57:31 INFO - Running post-action listener: _resource_record_post_action 04:57:31 INFO - ##### 04:57:31 INFO - ##### Running read-buildbot-config step. 04:57:31 INFO - ##### 04:57:31 INFO - Running pre-action listener: _resource_record_pre_action 04:57:31 INFO - Running main action method: read_buildbot_config 04:57:31 INFO - Using buildbot properties: 04:57:31 INFO - { 04:57:31 INFO - "project": "", 04:57:31 INFO - "product": "firefox", 04:57:31 INFO - "script_repo_revision": "production", 04:57:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:57:31 INFO - "repository": "", 04:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:57:31 INFO - "buildid": "20151224023002", 04:57:31 INFO - "pgo_build": "True", 04:57:31 INFO - "basedir": "/builds/slave/test-pgo", 04:57:31 INFO - "buildnumber": 153, 04:57:31 INFO - "slavename": "talos-linux64-ix-014", 04:57:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:57:31 INFO - "platform": "ubuntu64_hw", 04:57:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:57:31 INFO - "branch": "b2g-inbound", 04:57:31 INFO - "repo_path": "integration/b2g-inbound", 04:57:31 INFO - "revision": "1afb843f090784cb45d01a428773f4352f73a515", 04:57:31 INFO - "stage_platform": "linux64-pgo", 04:57:31 INFO - "builduid": "ee97a50b5a6f45d6ad4df6fbea594f4c", 04:57:31 INFO - "slavebuilddir": "test" 04:57:31 INFO - } 04:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:57:31 INFO - Running post-action listener: _resource_record_post_action 04:57:31 INFO - ##### 04:57:31 INFO - ##### Running download-and-extract step. 04:57:31 INFO - ##### 04:57:31 INFO - Running pre-action listener: _resource_record_pre_action 04:57:31 INFO - Running main action method: download_and_extract 04:57:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:57:31 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')]} 04:57:31 INFO - https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/test_packages.json 04:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/test_packages.json 04:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:57:34 INFO - Downloaded 1302 bytes. 04:57:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:57:34 INFO - Using the following test package requirements: 04:57:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:57:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'jsshell-linux-x86_64.zip'], 04:57:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:57:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:57:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:57:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:57:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:57:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:57:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:57:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:34 INFO - https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:57:39 INFO - Downloaded 23180694 bytes. 04:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:57:40 INFO - Return code: 0 04:57:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:57:42 INFO - Downloaded 23180694 bytes. 04:57:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:57:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:57:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:57:43 INFO - Return code: 0 04:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:43 INFO - https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:57:44 INFO - Downloaded 11132277 bytes. 04:57:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:57:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:57:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:57:44 INFO - Return code: 0 04:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:44 INFO - https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:57:46 INFO - Downloaded 54830183 bytes. 04:57:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:46 INFO - mkdir: /builds/slave/test-pgo/properties 04:57:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:57:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:57:46 INFO - Contents: 04:57:46 INFO - build_url:https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:57:46 INFO - Running post-action listener: _resource_record_post_action 04:57:46 INFO - Running post-action listener: set_extra_try_arguments 04:57:46 INFO - ##### 04:57:46 INFO - ##### Running populate-webroot step. 04:57:46 INFO - ##### 04:57:46 INFO - Running pre-action listener: _resource_record_pre_action 04:57:46 INFO - Running main action method: populate_webroot 04:57:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:46 INFO - '--tppagecycles', 04:57:46 INFO - '7'], 04:57:46 INFO - 'tests': ['tsvgm']}}, 04:57:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:57:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:57:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'tests': ['damp', 'tps']}, 04:57:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['damp', 'tps']}, 04:57:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:57:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:46 INFO - 'other': {'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore']}, 04:57:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore']}, 04:57:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore']}, 04:57:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore']}, 04:57:46 INFO - 'other_l64': {'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore']}, 04:57:46 INFO - 'other_nol64': {'tests': ['a11yr', 04:57:46 INFO - 'ts_paint', 04:57:46 INFO - 'tpaint', 04:57:46 INFO - 'sessionrestore', 04:57:46 INFO - 'sessionrestore_no_auto_restore']}, 04:57:46 INFO - 'svgr': {'tests': ['tsvgx', 04:57:46 INFO - 'tsvgr_opacity', 04:57:46 INFO - 'tart', 04:57:46 INFO - 'tscrollx', 04:57:46 INFO - 'cart']}, 04:57:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['tsvgx', 04:57:46 INFO - 'tsvgr_opacity', 04:57:46 INFO - 'tart', 04:57:46 INFO - 'tscrollx', 04:57:46 INFO - 'cart']}, 04:57:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'tests': ['tp5o']}, 04:57:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--e10s'], 04:57:46 INFO - 'tests': ['tp5o']}, 04:57:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--xperf_path', 04:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:46 INFO - 'tests': ['tp5n']}, 04:57:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:46 INFO - 'talos_options': ['--e10s', 04:57:46 INFO - '--xperf_path', 04:57:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:46 INFO - 'tests': ['tp5n']}}, 04:57:46 INFO - 'talos.zip': {'path': '', 04:57:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:46 INFO - Running post-action listener: _resource_record_post_action 04:57:46 INFO - ##### 04:57:46 INFO - ##### Running create-virtualenv step. 04:57:46 INFO - ##### 04:57:46 INFO - Running pre-action listener: _resource_record_pre_action 04:57:46 INFO - Running main action method: create_virtualenv 04:57:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:57:46 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 04:57:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:57:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:46 INFO - Using real prefix '/usr' 04:57:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:57:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:48 INFO - Installing pip.................done. 04:57:48 INFO - Return code: 0 04:57:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:57:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:57:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:57:48 INFO - Using env: {'DISPLAY': ':0', 04:57:48 INFO - 'HOME': '/home/cltbld', 04:57:48 INFO - 'LANG': 'en_US.UTF-8', 04:57:48 INFO - 'LANGUAGE': 'en_US:en', 04:57:48 INFO - 'LOGNAME': 'cltbld', 04:57:48 INFO - 'MAIL': '/var/mail/cltbld', 04:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:48 INFO - 'MOZ_NO_REMOTE': '1', 04:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:48 INFO - 'NO_EM_RESTART': '1', 04:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:48 INFO - 'SHELL': '/bin/bash', 04:57:48 INFO - 'SHLVL': '1', 04:57:48 INFO - 'TERM': 'linux', 04:57:48 INFO - 'TMOUT': '86400', 04:57:48 INFO - 'USER': 'cltbld', 04:57:48 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:48 INFO - '_': '/tools/buildbot/bin/python'} 04:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:49 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 04:57:49 INFO - Cleaning up... 04:57:49 INFO - Return code: 0 04:57:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:57:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:57:49 INFO - Using env: {'DISPLAY': ':0', 04:57:49 INFO - 'HOME': '/home/cltbld', 04:57:49 INFO - 'LANG': 'en_US.UTF-8', 04:57:49 INFO - 'LANGUAGE': 'en_US:en', 04:57:49 INFO - 'LOGNAME': 'cltbld', 04:57:49 INFO - 'MAIL': '/var/mail/cltbld', 04:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:49 INFO - 'MOZ_NO_REMOTE': '1', 04:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:49 INFO - 'NO_EM_RESTART': '1', 04:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:49 INFO - 'SHELL': '/bin/bash', 04:57:49 INFO - 'SHLVL': '1', 04:57:49 INFO - 'TERM': 'linux', 04:57:49 INFO - 'TMOUT': '86400', 04:57:49 INFO - 'USER': 'cltbld', 04:57:49 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:49 INFO - '_': '/tools/buildbot/bin/python'} 04:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:49 INFO - Downloading/unpacking psutil>=0.7.1 04:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:57:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:57:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:51 INFO - Installing collected packages: psutil 04:57:51 INFO - Running setup.py install for psutil 04:57:51 INFO - building 'psutil._psutil_linux' extension 04:57:51 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 04:57:51 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 04:57:51 INFO - building 'psutil._psutil_posix' extension 04:57:51 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 04:57:51 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 04:57:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:51 INFO - Successfully installed psutil 04:57:51 INFO - Cleaning up... 04:57:51 INFO - Return code: 0 04:57:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:57:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:57:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:57:51 INFO - Using env: {'DISPLAY': ':0', 04:57:51 INFO - 'HOME': '/home/cltbld', 04:57:51 INFO - 'LANG': 'en_US.UTF-8', 04:57:51 INFO - 'LANGUAGE': 'en_US:en', 04:57:51 INFO - 'LOGNAME': 'cltbld', 04:57:51 INFO - 'MAIL': '/var/mail/cltbld', 04:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:51 INFO - 'MOZ_NO_REMOTE': '1', 04:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:51 INFO - 'NO_EM_RESTART': '1', 04:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:51 INFO - 'SHELL': '/bin/bash', 04:57:51 INFO - 'SHLVL': '1', 04:57:51 INFO - 'TERM': 'linux', 04:57:51 INFO - 'TMOUT': '86400', 04:57:51 INFO - 'USER': 'cltbld', 04:57:51 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:51 INFO - '_': '/tools/buildbot/bin/python'} 04:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:57:53 INFO - Installing collected packages: mozsystemmonitor 04:57:53 INFO - Running setup.py install for mozsystemmonitor 04:57:53 INFO - Successfully installed mozsystemmonitor 04:57:53 INFO - Cleaning up... 04:57:53 INFO - Return code: 0 04:57:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:57:53 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')]} 04:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:53 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')]} 04:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:57:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:57:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:53 INFO - Using env: {'DISPLAY': ':0', 04:57:53 INFO - 'HOME': '/home/cltbld', 04:57:53 INFO - 'LANG': 'en_US.UTF-8', 04:57:53 INFO - 'LANGUAGE': 'en_US:en', 04:57:53 INFO - 'LOGNAME': 'cltbld', 04:57:53 INFO - 'MAIL': '/var/mail/cltbld', 04:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:53 INFO - 'MOZ_NO_REMOTE': '1', 04:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:53 INFO - 'NO_EM_RESTART': '1', 04:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:53 INFO - 'SHELL': '/bin/bash', 04:57:53 INFO - 'SHLVL': '1', 04:57:53 INFO - 'TERM': 'linux', 04:57:53 INFO - 'TMOUT': '86400', 04:57:53 INFO - 'USER': 'cltbld', 04:57:53 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:53 INFO - '_': '/tools/buildbot/bin/python'} 04:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:53 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:53 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 04:57:53 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 04:57:53 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 04:57:53 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 04:57:53 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 04:57:53 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 04:57:55 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:55 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 04:57:55 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 04:57:55 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 04:57:55 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 04:57:55 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 04:57:55 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 04:57:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:57:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:56 INFO - Downloading docopt-0.6.1.tar.gz 04:57:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:57:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:56 INFO - Running setup.py install for blobuploader 04:57:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:57:56 INFO - Running setup.py install for requests 04:57:56 INFO - Running setup.py install for docopt 04:57:56 INFO - Successfully installed blobuploader requests docopt 04:57:56 INFO - Cleaning up... 04:57:56 INFO - Return code: 0 04:57:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:57:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:57:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:56 INFO - Using env: {'DISPLAY': ':0', 04:57:56 INFO - 'HOME': '/home/cltbld', 04:57:56 INFO - 'LANG': 'en_US.UTF-8', 04:57:56 INFO - 'LANGUAGE': 'en_US:en', 04:57:56 INFO - 'LOGNAME': 'cltbld', 04:57:56 INFO - 'MAIL': '/var/mail/cltbld', 04:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:56 INFO - 'MOZ_NO_REMOTE': '1', 04:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:56 INFO - 'NO_EM_RESTART': '1', 04:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:57:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:57:56 INFO - 'SHELL': '/bin/bash', 04:57:56 INFO - 'SHLVL': '1', 04:57:56 INFO - 'TERM': 'linux', 04:57:56 INFO - 'TMOUT': '86400', 04:57:56 INFO - 'USER': 'cltbld', 04:57:56 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:56 INFO - '_': '/tools/buildbot/bin/python'} 04:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:57 INFO - Running setup.py (path:/tmp/pip-vTQNJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:57 INFO - Running setup.py (path:/tmp/pip-QmPv8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:57 INFO - Running setup.py (path:/tmp/pip-idTCSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:57 INFO - Running setup.py (path:/tmp/pip-DXyST3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:57 INFO - Running setup.py (path:/tmp/pip-xJfNP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:57 INFO - Running setup.py (path:/tmp/pip-DDPcDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:57 INFO - Running setup.py (path:/tmp/pip-ZS1Ci_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:57 INFO - Running setup.py (path:/tmp/pip-jvtt_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:57 INFO - Running setup.py (path:/tmp/pip-eNKliD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:57 INFO - Running setup.py (path:/tmp/pip-aL5kAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:57 INFO - Running setup.py (path:/tmp/pip-95geD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:57 INFO - Running setup.py (path:/tmp/pip-_VwDQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:57 INFO - Running setup.py (path:/tmp/pip-lcKsPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:58 INFO - Running setup.py (path:/tmp/pip-rDf7Vn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:58 INFO - Running setup.py (path:/tmp/pip-hLKyyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:58 INFO - Running setup.py (path:/tmp/pip-UybfaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:58 INFO - Running setup.py (path:/tmp/pip-SIRM51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:57:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:58 INFO - Running setup.py install for manifestparser 04:57:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:57:58 INFO - Running setup.py install for mozcrash 04:57:58 INFO - Running setup.py install for mozdebug 04:57:58 INFO - Running setup.py install for mozdevice 04:57:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:57:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:57:58 INFO - Running setup.py install for mozfile 04:57:58 INFO - Running setup.py install for mozhttpd 04:57:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:57:58 INFO - Running setup.py install for mozinfo 04:57:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Running setup.py install for mozInstall 04:57:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Running setup.py install for mozleak 04:57:59 INFO - Running setup.py install for mozlog 04:57:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Running setup.py install for moznetwork 04:57:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Running setup.py install for mozprocess 04:57:59 INFO - Running setup.py install for mozprofile 04:57:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Running setup.py install for mozrunner 04:57:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:57:59 INFO - Running setup.py install for mozscreenshot 04:57:59 INFO - Running setup.py install for moztest 04:57:59 INFO - Running setup.py install for mozversion 04:58:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:58:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:00 INFO - Cleaning up... 04:58:00 INFO - Return code: 0 04:58:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:00 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')]} 04:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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')]} 04:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:58:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:58:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:00 INFO - Using env: {'DISPLAY': ':0', 04:58:00 INFO - 'HOME': '/home/cltbld', 04:58:00 INFO - 'LANG': 'en_US.UTF-8', 04:58:00 INFO - 'LANGUAGE': 'en_US:en', 04:58:00 INFO - 'LOGNAME': 'cltbld', 04:58:00 INFO - 'MAIL': '/var/mail/cltbld', 04:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:00 INFO - 'MOZ_NO_REMOTE': '1', 04:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:00 INFO - 'NO_EM_RESTART': '1', 04:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:00 INFO - 'SHELL': '/bin/bash', 04:58:00 INFO - 'SHLVL': '1', 04:58:00 INFO - 'TERM': 'linux', 04:58:00 INFO - 'TMOUT': '86400', 04:58:00 INFO - 'USER': 'cltbld', 04:58:00 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:00 INFO - '_': '/tools/buildbot/bin/python'} 04:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:00 INFO - Running setup.py (path:/tmp/pip-lHJM6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:00 INFO - Running setup.py (path:/tmp/pip-0FDRPE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:00 INFO - Running setup.py (path:/tmp/pip-TVsp7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:00 INFO - Running setup.py (path:/tmp/pip-ABoDk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:00 INFO - Running setup.py (path:/tmp/pip-OjEEqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:00 INFO - Running setup.py (path:/tmp/pip-P5LU2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:00 INFO - Running setup.py (path:/tmp/pip-FgaV4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:00 INFO - Running setup.py (path:/tmp/pip-9Mf0Mo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:00 INFO - Running setup.py (path:/tmp/pip-zaNvXd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:00 INFO - Running setup.py (path:/tmp/pip-l85nr6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:01 INFO - Running setup.py (path:/tmp/pip-k6L_su-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:01 INFO - Running setup.py (path:/tmp/pip-tWd6X1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:01 INFO - Running setup.py (path:/tmp/pip-9dlIMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:01 INFO - Running setup.py (path:/tmp/pip-XkQXPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:01 INFO - Running setup.py (path:/tmp/pip-YHC5KI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:01 INFO - Running setup.py (path:/tmp/pip-iJ00g8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:01 INFO - Running setup.py (path:/tmp/pip-7bFbjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:58:01 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)) 04:58:01 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)) 04:58:01 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)) 04:58:01 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)) 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:03 INFO - Downloading blessings-1.5.1.tar.gz 04:58:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:58:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:03 INFO - Installing collected packages: blessings 04:58:03 INFO - Running setup.py install for blessings 04:58:03 INFO - Successfully installed blessings 04:58:03 INFO - Cleaning up... 04:58:03 INFO - Return code: 0 04:58:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:58:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:58:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:58:03 INFO - Reading from file tmpfile_stdout 04:58:03 INFO - Current package versions: 04:58:03 INFO - argparse == 1.2.1 04:58:03 INFO - blessings == 1.5.1 04:58:03 INFO - blobuploader == 1.2.4 04:58:03 INFO - docopt == 0.6.1 04:58:03 INFO - manifestparser == 1.1 04:58:03 INFO - mozInstall == 1.12 04:58:03 INFO - mozcrash == 0.16 04:58:03 INFO - mozdebug == 0.1 04:58:03 INFO - mozdevice == 0.47 04:58:03 INFO - mozfile == 1.2 04:58:03 INFO - mozhttpd == 0.7 04:58:03 INFO - mozinfo == 0.9 04:58:03 INFO - mozleak == 0.1 04:58:03 INFO - mozlog == 3.1 04:58:03 INFO - moznetwork == 0.27 04:58:03 INFO - mozprocess == 0.22 04:58:03 INFO - mozprofile == 0.28 04:58:03 INFO - mozrunner == 6.11 04:58:03 INFO - mozscreenshot == 0.1 04:58:03 INFO - mozsystemmonitor == 0.0 04:58:03 INFO - moztest == 0.7 04:58:03 INFO - mozversion == 1.4 04:58:03 INFO - psutil == 3.1.1 04:58:03 INFO - requests == 1.2.3 04:58:03 INFO - wsgiref == 0.1.2 04:58:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:58:03 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')]} 04:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:03 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')]} 04:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:58:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:58:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:03 INFO - Using env: {'DISPLAY': ':0', 04:58:03 INFO - 'HOME': '/home/cltbld', 04:58:03 INFO - 'LANG': 'en_US.UTF-8', 04:58:03 INFO - 'LANGUAGE': 'en_US:en', 04:58:03 INFO - 'LOGNAME': 'cltbld', 04:58:03 INFO - 'MAIL': '/var/mail/cltbld', 04:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:03 INFO - 'MOZ_NO_REMOTE': '1', 04:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:03 INFO - 'NO_EM_RESTART': '1', 04:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:03 INFO - 'SHELL': '/bin/bash', 04:58:03 INFO - 'SHLVL': '1', 04:58:03 INFO - 'TERM': 'linux', 04:58:03 INFO - 'TMOUT': '86400', 04:58:03 INFO - 'USER': 'cltbld', 04:58:03 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:03 INFO - '_': '/tools/buildbot/bin/python'} 04:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 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)) 04:58:03 INFO - Cleaning up... 04:58:03 INFO - Return code: 0 04:58:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:58:03 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')]} 04:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:03 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')]} 04:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:58:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:58:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:03 INFO - Using env: {'DISPLAY': ':0', 04:58:03 INFO - 'HOME': '/home/cltbld', 04:58:03 INFO - 'LANG': 'en_US.UTF-8', 04:58:03 INFO - 'LANGUAGE': 'en_US:en', 04:58:03 INFO - 'LOGNAME': 'cltbld', 04:58:03 INFO - 'MAIL': '/var/mail/cltbld', 04:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:03 INFO - 'MOZ_NO_REMOTE': '1', 04:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:03 INFO - 'NO_EM_RESTART': '1', 04:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:03 INFO - 'SHELL': '/bin/bash', 04:58:03 INFO - 'SHLVL': '1', 04:58:03 INFO - 'TERM': 'linux', 04:58:03 INFO - 'TMOUT': '86400', 04:58:03 INFO - 'USER': 'cltbld', 04:58:03 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:03 INFO - '_': '/tools/buildbot/bin/python'} 04:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:04 INFO - Downloading/unpacking jsonschema 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:58:05 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:05 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 04:58:05 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 04:58:05 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 04:58:05 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 04:58:05 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 04:58:05 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 04:58:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:58:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:06 INFO - warning: no files found matching '*.txt' 04:58:06 INFO - no previously-included directories found matching 'build' 04:58:06 INFO - no previously-included directories found matching 'dist' 04:58:06 INFO - no previously-included directories found matching '.git*' 04:58:06 INFO - Installing collected packages: jsonschema, functools32 04:58:06 INFO - Running setup.py install for functools32 04:58:06 INFO - warning: no files found matching '*.txt' 04:58:06 INFO - no previously-included directories found matching 'build' 04:58:06 INFO - no previously-included directories found matching 'dist' 04:58:06 INFO - no previously-included directories found matching '.git*' 04:58:06 INFO - Successfully installed jsonschema functools32 04:58:06 INFO - Cleaning up... 04:58:06 INFO - Return code: 0 04:58:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:58:06 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')]} 04:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 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')]} 04:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31b204ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, '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': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', '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 04:58:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:58:06 INFO - Using env: {'DISPLAY': ':0', 04:58:06 INFO - 'HOME': '/home/cltbld', 04:58:06 INFO - 'LANG': 'en_US.UTF-8', 04:58:06 INFO - 'LANGUAGE': 'en_US:en', 04:58:06 INFO - 'LOGNAME': 'cltbld', 04:58:06 INFO - 'MAIL': '/var/mail/cltbld', 04:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:06 INFO - 'MOZ_NO_REMOTE': '1', 04:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:06 INFO - 'NO_EM_RESTART': '1', 04:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:06 INFO - 'SHELL': '/bin/bash', 04:58:06 INFO - 'SHLVL': '1', 04:58:06 INFO - 'TERM': 'linux', 04:58:06 INFO - 'TMOUT': '86400', 04:58:06 INFO - 'USER': 'cltbld', 04:58:06 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:06 INFO - '_': '/tools/buildbot/bin/python'} 04:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:06 INFO - Downloading/unpacking flake8 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:06 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 04:58:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:58:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:58:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:58:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 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 04:58:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:08 INFO - no previously-included directories found matching 'docs/_build' 04:58:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:08 INFO - Running setup.py install for pep8 04:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:08 INFO - no previously-included directories found matching 'docs/_build' 04:58:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:58:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:09 INFO - Cleaning up... 04:58:09 INFO - Return code: 0 04:58:09 INFO - Running post-action listener: _resource_record_post_action 04:58:09 INFO - Running post-action listener: _start_resource_monitoring 04:58:09 INFO - Starting resource monitoring. 04:58:09 INFO - ##### 04:58:09 INFO - ##### Running install step. 04:58:09 INFO - ##### 04:58:09 INFO - Running pre-action listener: _resource_record_pre_action 04:58:09 INFO - Running main action method: install 04:58:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:58:09 INFO - Reading from file tmpfile_stdout 04:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:58:09 INFO - Reading from file tmpfile_stdout 04:58:09 INFO - Output received: 04:58:09 INFO - Usage: mozinstall [options] installer 04:58:09 INFO - Options: 04:58:09 INFO - -h, --help show this help message and exit 04:58:09 INFO - -d DEST, --destination=DEST 04:58:09 INFO - Directory to install application into. [default: 04:58:09 INFO - "/builds/slave/test-pgo"] 04:58:09 INFO - --app=APP Application being installed. [default: firefox] 04:58:09 INFO - mkdir: /builds/slave/test-pgo/build/application 04:58:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:58:25 INFO - Reading from file tmpfile_stdout 04:58:25 INFO - Output received: 04:58:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:58:25 INFO - Running post-action listener: _resource_record_post_action 04:58:25 INFO - ##### 04:58:25 INFO - ##### Running run-tests step. 04:58:25 INFO - ##### 04:58:25 INFO - Running pre-action listener: _resource_record_pre_action 04:58:25 INFO - Running main action method: run_tests 04:58:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:58:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:58:25 INFO - Python 2.7.3 04:58:25 INFO - Return code: 0 04:58:25 INFO - grabbing minidump binary from tooltool 04:58:25 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')]} 04:58:25 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 0x25bf840>, '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 0x252c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:58:25 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 04:58:25 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 04:58:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:25 INFO - Return code: 0 04:58:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:58:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:58:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:58:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:58:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:58:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:58:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:58:26 INFO - Return code: 0 04:58:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 04:58:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 04:58:26 INFO - Using env: {'DISPLAY': ':0', 04:58:26 INFO - 'HOME': '/home/cltbld', 04:58:26 INFO - 'LANG': 'en_US.UTF-8', 04:58:26 INFO - 'LANGUAGE': 'en_US:en', 04:58:26 INFO - 'LOGNAME': 'cltbld', 04:58:26 INFO - 'MAIL': '/var/mail/cltbld', 04:58:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:58:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:26 INFO - 'MOZ_NO_REMOTE': '1', 04:58:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:58:26 INFO - 'NO_EM_RESTART': '1', 04:58:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:58:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:58:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:58:26 INFO - 'SHELL': '/bin/bash', 04:58:26 INFO - 'SHLVL': '1', 04:58:26 INFO - 'TERM': 'linux', 04:58:26 INFO - 'TMOUT': '86400', 04:58:26 INFO - 'USER': 'cltbld', 04:58:26 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465', 04:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:26 INFO - '_': '/tools/buildbot/bin/python'} 04:58:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 04:58:26 INFO - mozversion application_buildid: 20151224023002 04:58:26 INFO - mozversion application_changeset: 1afb843f090784cb45d01a428773f4352f73a515 04:58:26 INFO - mozversion application_display_name: Nightly 04:58:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:26 INFO - mozversion application_name: Firefox 04:58:26 INFO - mozversion application_remotingname: firefox 04:58:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:58:26 INFO - mozversion application_vendor: Mozilla 04:58:26 INFO - mozversion application_version: 46.0a1 04:58:26 INFO - mozversion platform_buildid: 20151224023002 04:58:26 INFO - mozversion platform_changeset: 1afb843f090784cb45d01a428773f4352f73a515 04:58:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:58:26 INFO - mozversion platform_version: 46.0a1 04:58:26 INFO - using testdate: 1450961906 04:58:26 INFO - actual date: 1450961906 04:58:26 INFO - starting webserver on 'localhost:57500' 04:58:26 INFO - SUITE-START | Running 3 tests 04:58:26 INFO - TEST-START | dromaeo_css 04:58:26 INFO - operating with platform_type : linux_ 04:58:26 INFO - Initialising browser for dromaeo_css test... 04:58:26 INFO - TEST-INFO | started process 7125 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE0oBL7/profile http://localhost:57500/getInfo.html) 04:58:30 INFO - PROCESS | 7125 | __metrics Screen width/height:1600/1200 04:58:30 INFO - PROCESS | 7125 | colorDepth:24 04:58:30 INFO - PROCESS | 7125 | Browser inner width/height: 1024/697 04:58:30 INFO - PROCESS | 7125 | __metrics 04:58:30 INFO - PROCESS | 7125 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:58:30 INFO - PROCESS | 7125 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:31 INFO - TEST-INFO | 7125: exit 0 04:58:31 INFO - Browser initialized. 04:58:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:31 INFO - TEST-INFO | started process 7220 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE0oBL7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:43 INFO - PROCESS | 7220 | RSS: Main: 150646784 04:58:43 INFO - PROCESS | 7220 | 04:59:35 INFO - PROCESS | 7220 | 1450961975123 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:01:43 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57500/tests/dromaeo/cssquery-ext.html) 05:01:44 INFO - PROCESS | 7220 | RSS: Main: 272203776 05:01:44 INFO - PROCESS | 7220 | 05:04:47 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-ext.html (next: http://localhost:57500/tests/dromaeo/cssquery-jquery.html) 05:04:47 INFO - PROCESS | 7220 | RSS: Main: 241598464 05:04:47 INFO - PROCESS | 7220 | 05:07:49 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57500/tests/dromaeo/cssquery-mootools.html) 05:07:50 INFO - PROCESS | 7220 | RSS: Main: 235421696 05:07:50 INFO - PROCESS | 7220 | 05:10:52 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57500/tests/dromaeo/cssquery-prototype.html) 05:10:52 INFO - PROCESS | 7220 | RSS: Main: 216150016 05:10:52 INFO - PROCESS | 7220 | 05:13:55 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57500/tests/dromaeo/cssquery-yui.html) 05:13:55 INFO - PROCESS | 7220 | RSS: Main: 219840512 05:13:55 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | Cycle 1(1): loaded http://localhost:57500/tests/dromaeo/cssquery-yui.html (next: http://localhost:57500/tests/dromaeo/cssquery-dojo.html) 05:16:58 INFO - PROCESS | 7220 | RSS: Main: 299679744 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | __start_tp_report 05:16:58 INFO - PROCESS | 7220 | _x_x_mozilla_page_load 05:16:58 INFO - PROCESS | 7220 | _x_x_mozilla_page_load_details 05:16:58 INFO - PROCESS | 7220 | |i|pagename|runs| 05:16:58 INFO - PROCESS | 7220 | |0;dojo.html;3110.984445077774;3180.586523751912;3190.69688379604;3218.163277547837;3252.788568743032;5080.314157588725;5204.245384419266;5332.733363331832;5352.116900711383;5363.275957745708;5248.0815857225025;5280.313559237304;5291.259223708684;5325.600579956509;5389.541888939435;4776.188048031843;4799.784009719571;4806.543378379057;4846.927296090562;4931.679440836352;4856.514348565151;4857.73282469464;4873.756312184394;4898;4955.628327875405;4833.685810422311;4872.561469467747;4897.436794768611;4899.681520701179;4922.729249891255;4806.639502037327;4815.3258543803895;4818.445878723956;4821.493743156988;4845.41854977405;4802.207635740098;4803.3035209894715;4803.855884323476;4810.807567697288;4823.541763532458;4985.426675932278;5087.821926232601;5165.612579056548;5241.764120614582;5263.710495922723;5764.855878603026;5783.190353350535;5783.942160578383;5788.97105514474;5794.536437085023;5507.697076660782;5774;5780.942190578083;5799.536037117021;5801.187833703285;5341.225522299244;5356.946430535722;5363.19552067193;5402.837914862561;5458;5855.560832937546;5870.207521984563;5902.8819423611285;5915.08316210988;5960.970195149083;5495;5672.290963629546;5673.687947162945;5675.262215911905;5678.034734095214;5481.671099734029;5513.476219759116;5523.917141242885;5585.581081418829;5659.490645841894;5593.8321850344555;5605.635633683797;5619.269494965628;5629.127485239795;5629.549636029108;5500.1749737539685;5623.156526521055;5624.746886390122;5626.971865140648;5633.042382794934;4355.891102722458;4370.519242883281;4443.777811109431;4483.170613436525;4483.798229079699;3958.3072962232072;3960.7227494075714;3966.940495892564;3974.2448934702893;3994.960050399459;5174.560162386239;5315.6013299002725;5341.252224688546;5342.332208473941;5343.599230057761;5715.2855893013375;5731.914021289684;5755.6834374108985;5831.62094463867;5849.970750146222;5267.1309233976735;5268.947310526923;5270.525652691276;5272.92090618641;5313.123334649817;4748.572628463386;4794.352762377034;4795.808167673324;4838.225883858636;4842.249451335048;5792.855178620568;5880.529557635465;5893.263342082239;5894.970525147347;5915.37888521699;5735.827925162252;5737.139429085503;5739.827805165852;5746.856328591652;5760.913586296293;5915.58590898633;5917.230760001173;5919.91120133207;5925.970370148121;5930.199423077829;5457.781688732406;5460.945390546044;5575.749091290821;5613.961417137843;5646.096624540054;5699.971500142473;5730.255066841284;5734.598578099493;5737.426257374229;5768.307803063659;5610.13042978339;5614.326280846324;5614.887702246014;5615.2700148980375;5622.156676498558;5303.46965303482;5467.699276539828;5561.360443549043;5635.464630860061;5682.119271512922;5520.254765606753;5522.144067669517;5524.447555244444;5529.364123125731;5531.419200983839;5407.783688652567;5601.747921343631;5621.578381621313;5641.774329026793;5641.830745077655;5420.7289635518855;5481.671099734029;5483.917741233964;5526;5544.0575102231915 05:16:58 INFO - PROCESS | 7220 | |1;ext.html;537.4544836990455;540.7755781350739;540.8080131553298;587.4067192135941;592.8784599157174;29507;30478.54282185769;30490.237744056383;30499.390012199743;38544.22911541768;42799;43810;43843.56156438435;43874.735031796146;43958.340624890654;8766.342524310687;8894.199522043014;8921.866172007425;8946.731598052036;8950.597223124942;7671.347935425468;7865.056193256817;8459.069502354736;8524.488530688148;10529.315594486372;10413.687589372332;10526.42104684242;10530.315529490597;10543.47282635869;10544.630937917174;10448.529816158252;10498.737531561696;10543.894561054369;10549.78900421991;10562.735931601695;7657.65540550671;7848.254415830487;7853.725119620786;10499.527521261562;10803.189760767895;39518;39786.60213397858;39949.20101597981;39986.60013399858;40015.39976900349;3267.7059064684295;3382.678645528671;3430.7255419566377;3435.209901722618;3440.55272814535;27702.445951081067;27726;27852;28045.43909121806;28466;3789.5263092113487;3975.1453437510786;4009;4024.476818013669;4048.1701251243426;272343;272756;273729;274083.6295818528;274272;53927.730361347945;54709;59297.40702593005;59553.70223148856;59616;70493;71640;72131.27868721246;72230.27769722341;72382;13745.106568073043;14216.786748198785;14253.643658908402;14253.928730356489;14254.572362829133;9460.47967361788;9617.326787124974;10113.59545618167;10423.583056677648;10882.183836212316;19959.20163193456;20376.28682996088;20389.184432622827;20403.897980510003;20472.385828425173;8123.83752324962;8165.345752920897;8204.466709663853;8297.626606802709;8386.706465273808;905.6467977488785;928.6007016982762;1113.124770987448;1121.9831702524468;1122.259308856151;28264.576031359546;28307.71692283092;28357;28664;28964.42071158607;956.4213650741341;1012.7670635753818;1023.9078482936422;1060.9151267898549;1164.3654208456412;16381.67236655284;16928;17115;17168;17172;393729;396019;400505;401862;401867;54433.72783136059;54949.17576236359;54954;54966.17550736742;55133.724331378886;1286.2218357893528;1299.2983788753968;1299.4607237996315;1312.3831799054428;1318.6835159561635;28687.282817929718;29255.561166582094;29357.7064229355;29735.553966690084;29762.553561697026;41262.79368603138;42069.79302069891;42081.57918420777;43754.56245437632;44215;311516;315723;317916;317926;318278;29111.708882910898;29277.41445171042;29331.85334073316;29536.261593460335;29559.704402956555;37632.62367376401;38712.80643596764;38965;39406.60593394144;39456.80271598624;32561;32758.508622370206;33100.33799323952;35702.71425305921;36452;35183;36087.63912360843;36353;36371.81814090913;36544.817275914516;34849.65150348464;35111.64888351084;35463.290734185684;35586.46620300749;35600;30830.84584577063;32599.674003260614;33032.83483582567;33035.834820825745;33077.66922330746;21893.671594926407;22138.667919981537;22180.445488862908;22208.555828883655;22284.554308914056 05:16:58 INFO - PROCESS | 7220 | |2;jquery.html;346.37306475279746;349.1654944682209;354.2595974413477;357.4227622389841;359.4410691374914;14013.92993035036;14324.068935519184;16170.191490425475;16489.752653710188;17254.654906901855;14005.649858753537;14163.575092747209;14291.356888939996;14295.285235738198;14309.928450357733;5262.131748261542;5327.600429967749;5442.591805614575;5452.154915988028;5465.781368745265;3884.766913985156;4003.719739618228;5376.354837419515;5824.854378640547;5984.910226346608;5903.173555702184;5912.467877890989;5913.793017244398;5936.198613187229;5950.55370847186;5774.364819869811;5884.617499862538;5885.823425297248;5893.351731309574;5894.292684877821;5195.882885179667;5205.27126202332;5229;5229.111051121318;5229.294045303874;20332.288369906983;20717.482062948548;20984.685229721566;21149.25977590777;21213.257535986166;2129.2654034358275;2144.9571008579896;2156.5363446859;2171.4354267890303;2190.1348967157883;13076.607701768962;13300.73398532024;13308.467661293633;13384.130031548015;13495.66260843477;1767.814379490148;1809.6290260496567;1831.3498707958615;1887.8395336396422;1891.2624076610134;59921.40078599202;60717;60751.69624151851;61126.694366528325;63002.68498657523;9497.952510237405;9634.277429192838;9836.114749672564;9844.60621575129;9895;12725.93637031809;12739.29933853647;12746.872531274754;12755.87244127547;12789.61631151067;6723.731050757915;6761.425278851254;7011.824704382431;7050.294970503011;7086.185088714864;6275.748970041239;6296.905546416808;6308.842278943063;6334.113224148623;6334.5565810393755;5954.940450595439;5962.731677074542;5973.253343332083;5977.551683623746;6017.585867321176;1650.7949197086195;1733.4972857871076;1739.443378119015;1747.1788259518007;1748.5104170832187;839.4585492357395;913.1553313185277;958.5063692198523;964.5225613321311;993.9602415903283;17266.913665431843;17967.191476383596;18128.90935545314;18172.45482635523;18322.267109315744;938.8920274168559;944.9102335278137;981.0434826044692;999.7850462150527;1020.0156848640949;10305.74235644115;10527.052565269008;10608;10615.203859710553;10621.309614875008;485563;494165;503484.96515034384;511506;512141;70678.18320466061;78054;79898;82859;83413.58293208617;1121.1703339528854;1135.211028335299;1140.3784937209075;1176.311857563318;1180.3213152437384;14684.486042988445;15465.768013479581;15550.377984880479;15891.920540397225;16255.837441625432;34648.653513464546;34991.30017399587;35559.64440355667;35730.64269357377;36184.81907590445;42046.57953420427;42410.36384454174;43300.56699432965;43348.916277093325;44311.778441107585;9663.806723865624;9818.116369526777;9931.155851752683;10054.095131438205;10088;17155;17191.7421238679;17328.82671173272;17790.110494475484;18340.724889126406;10299.897001029894;11083.33499989971;11499.54001839917;13215;14148.292585370484;13162.670933226746;13323.600291991255;13719;14140.080894741808;14538.563843084725;11825.290482571074;12084.335361555199;13932.30338483092;14344;14863;8502.36232282569;8551.486910785372;9282;9462.101100395726;9465.574049167666;10184.083432491112;13793;14081.718365632425;14331.140131592138;14352.49766258176 05:16:58 INFO - PROCESS | 7220 | |3;mootools.html;1245.613859703492;1363.6181869076656;1371.1430356027483;1446.3708286895194;1550.0699580251844;6498.187726534184;7099.041629380039;7214.494985351028;7236.529625574347;7236.927630723691;7460.440466964972;7496.062992125984;7546.358559522447;7564.130125035623;7588.9241107588905;1963.3520938090467;2004.9699254511122;2117.470632341918;2153.816925561321;2156.3962090614573;2241.9103235870625;2293.4266433391654;2294.231432470116;2294.724633044037;2296.5636529059507;2141.2612648636273;2165.5560610074895;2174.3042226487532;2184.43204766761;2186.3440967709703;2144.378130342199;2182.9890850545644;2206.856554323964;2219.511707424372;2244.7418546867157;2222.3221917315213;2247.763984781591;2261.2650888461317;2271.102914348823;2272.227442669484;7399.593022383767;7450;7455.739049133309;7456.888146677804;7468.738594149233;4241.151769646083;4331.436913201295;4338.891527711801;4343.283358245917;4344.304911214223;2923.313021439981;2970.925726856846;2998.625171853518;3015.834129122897;3031.7271445570004;1000.3997601439152;1001.3591301567003;1018.1244130048152;1034.6223628375665;1048.7378155461136;10122.139618132467;10138.847917281246;10153.340032897911;10157;10170.491475426274;4057.330540460791;4091.652209562161;4122.505299364096;4158.022864626811;4164.875053748392;8702.738917832476;8742.519161446182;8747.737567872973;8752.824943501095;8761.123887611187;4332.848350307724;4338.6312163466455;4353.36876152956;4360.825566977349;4363;3930.8231129598666;3931.0761970936805;3932.075962148893;3932.5477570079806;3933.9606603934167;3130.139211716796;3306.834658267077;3360.1095709636966;3439.3637177122314;3509.9122521936647;1114.899659030675;1123.6685177872548;1136.602189233778;1141.7431078007548;1163.4299193395175;1045.9581616735397;1064.2337516987757;1064.4411683866033;1076.9461526923778;1112.0491979357694;7169.928300717031;7233.132024157135;7237.095363079615;7245.7826265212125;7250.093738282715;1013.159077965287;1013.310948554975;1014.2899970021015;1041.265907535186;1047.2826114111706;5594.832155035356;5667.093265077568;5667.886642267132;5672.09246520563;5672.659640421588;8490.745277641681;8606.612702428405;8764.56177191138;8767.693130740394;8869.955650221837;8697.391182617155;8759.781005474786;8788.95605521981;8800.735977920673;8803.823923521622;6826.180858297036;6930.13373328334;6995.230524642387;7044.366007059287;7047.40097091753;6796.96601517009;6797.524173307821;6825.317468253135;6830.726770929107;6835.282295358916;7727.884081738891;7783.92216077832;8030.799230019296;8046.235607617267;8046.798830029296;8002.717187710691;8103.0681471631515;8118;8241.752747417588;8260.793480163044;6450.48396128318;6527;6579.046038324512;6610.2398224204835;6664.333566643297;6432.9678351607945;6539.6403197824575;7144.749933752294;7153.2131465537705;7207.783766487014;5457.808976685797;5558;6717.462602991651;6857.27998560164;6991.965040174767;6722.327767223434;6768.289329620319;6777.93222067773;6881.036654868422;6885.277045910308;6803.285655006153;6861.421872969146;6861.656917154222;6877.759278425231;6881.174259088942;6285.397223707925;6350.333215012542;6350.714217860115;6352.9047064293145;6354.078658594385;6254.593451425642;6283.5287353449585;6283.71723272463;6305;6429.260635027032 05:16:58 INFO - PROCESS | 7220 | |4;prototype.html;336.2451296838598;337;341.9521267022616;342.16170382562717;351.19225780704375;5877.764889404424;5943.375945525722;5945.672987985665;5957.2851257849115;5959.374265702104;5845.824625261238;5853.268341457318;5857.970710146444;5859.296884373871;5860.443257890493;4579.885502862422;4581.083783243364;4585.656075794321;4586.610138138262;4589.518100599439;4415.845445409412;4520.254158063915;4540.545945405466;4544.863654090383;4566.97716511417;4513.390692256553;4514.616257618107;4521.434820647419;4526.3210518422175;4526.479454862683;4291.249031419505;4377.912441751179;4400.163968845909;4525.9547404525865;4531.773411329436;3934.7639141651593;3945.4279129526058;3961.227560625679;3963.2271707017144;3967.6230758077936;5653.971730141364;5655.491005809456;5664.85837854057;5669.206311116447;5671.9716401418145;4992.076465853828;5097.949020509822;5106.183010718267;5148.073346797575;5256.26412302278;6145.539084568631;6206.4173635723055;6216.751329946796;6230.2523697156175;6233.844153896189;4360.21516127097;4365.43249377582;4366.497852746911;4368.978155109204;4373.2565463871215;6359.682015899187;6444.8388790280615;6486.708098135595;6510.21877374718;6513.2509761377105;4483.843065492757;4498.077894031716;4500.819967201275;4501.572350626685;4506.662000349921;4560.840370587013;4561.2473941799235;4562.133194692998;4562.403158894361;4568.520305367955;5230.686158830483;5235.848113415119;5242.082635538842;5246.213068039749;5251.238570407269;6143.631382116998;6273.498120150377;6284.780032698834;6288.937110628926;6289.465395441347;1589.8410158984009;1598.7202239608023;1601.591594143486;1601.9519414417587;1602.8156761972289;1055.1611468882256;1072.822984207597;1076.4510099849133;1089.1722291058852;1101.3502033800096;5903.173555702205;5908.645481271137;5916.467517923407;5918.141869428995;5920.171176035358;6446.194225721785;6448.129502517194;6448.935510644834;6451.000094985285;6465.127207826978;5860.619059761102;5890.8821823563285;5902.61632993854;5924.229850119457;5934.1692163097205;3438.432658611301;3517.894463166058;3519.5424594803026;3520.119970007498;3522.2955408917805;6760.661966901635;6793.048973143764;6802.319768023257;6806.149231346082;6806.149231346082;6387.776427825004;6552.213734351908;6701;6704.363085506869;6708.262091169968;6600.636964966973;6640.966795165993;6666.933330666729;6739.629320387327;6749.730010799612;6471.805845824632;6533.346665333429;6534.444572211225;6535.44448721864;6553.5084868635995;6325.6204627720645;6335.239771227482;6432.09950606906;6450.8064758057335;6465.3857883501;6706.0611514389;6755.2231493378895;6762.357576030269;6763.357481039294;6766.729330826712;4499.122671079239;4526.932096018497;4543.863684089482;4548.5906268436;4549.3176023596725;6330.936690633219;6543.247526534319;6544.574602650812;6553.770618028346;6557.311482294291;6308.589941653778;6328.746850126127;6329.588576742497;6353.983362661952;6362.522810789117;6321.051842223703;6327.462165715966;6333.96833015832;6337.049442583465;6341.682915854097;6101.328853825987;6226.59527130735;6226.62640241587;6227.252729672468;6239.438450539473;6357.4596159326975;6366.586171898997;6368.267649220214;6373;6373.936260637334;6181.567290289637;6194.473469755121;6202;6213.850437669045;6220.688965551795 05:16:58 INFO - PROCESS | 7220 | |5;yui.html;756.0285033731652;766.5132640773107;772.8647486689829;792.4690457393546;808.0303635637237;13601.52394666187;13835.792463113048;13874.653133671663;13880.305984700775;13902.791458128137;13233.602991910235;13365.599032029031;13384.464621415133;13420.731585368287;13429;681.924988251292;689.1007235557595;717.5264325545141;729.6752944939477;813.9552324622143;829.5976451421056;833.0794472108294;837.1335667584052;837.9162083791603;839.5760141128721;869.9173578510031;876.7325965580495;877.4998250996935;878.3895192840978;878.8505953987806;697.5709938387905;706.0750416953807;850.544958447234;866.2204016385241;866.2982983783156;637.6206157336377;637.8182218067828;638.4923985431593;641.1600802948153;641.2593454559991;12797.296148711817;12951.805722914163;12961.157524760954;12977.286249256287;13001.60995170137;11392.316461012282;11703.882961170364;11787.587434439753;12070.69823254417;12173.08701847365;10199.235057370654;10227.43749093807;10467.267291289612;10760.892391076068;10921.617743379024;3540.150363912642;3574.6067932527403;3599.8200089995657;3603.513525674027;3616.258666973264;50088.24867626988;50533.24200137001;50838.491615083745;50884;50974;9054.728358149267;9082.636694532277;9110.134537218953;9151.17639412456;9682.515874206261;16471.423500177676;16692.916535417244;16694.165291735364;16718.24767885448;16728;6660.766873159513;6758.966205168943;6773.322667733188;6845.315468453215;6870.416014638811;4133.586641335843;4175.415441838145;4181.393697913846;4193.622573968358;4267.103908179317;2780.2354352552807;2802.0613094613127;2802.467531169071;2802.5936239245193;2804.7055059218897;525.4535283305396;550.3148580017823;556.246286282082;560.9859753506195;562.9437056294338;523.3379774585153;587.6973358720262;614.2598169206096;617.274702224884;685.8559702462538;9071.81856362869;9129.360944733804;9165.358424910326;9256.120668536478;9349.719508414759;587.700272860844;625.3933684326196;643.240975648739;643.8197304754676;663.8240866170469;3950.48643676326;4086.3053280942313;4142.233686767958;4158.2307273154565;4178.582141785858;56850.03074677099;61883;62341;62410.37589624136;62433.375666243664;49996.750016250415;50633.74683126635;51519.48480515147;52233.7388313056;52444.73777631164;47794.28308575374;48122;48319.27521087186;48453.27320090202;49262.50737492651;8945.552722363986;9018.549072546215;9160.404573702688;9161.816763664823;9216.861747073934;36947.63052369442;36971.26057478889;37342.626573735004;37549.81225093857;38582;46063.539364605924;46856.84574696849;47088.29367559558;47205;47622;11174.329540227613;11286.322820630789;11319.434028298718;11418.657440276806;12046;12007.39963001829;12010.939945300566;12070.637880863587;12078.879211207775;13109.213447193199;11758.412079395825;11953.282803031845;12249.510019599473;12272.38638068111;12305.323207223331;11429.314241145557;11608.941955290169;11622.709432263922;11996.700082498008;12024.639260822189;10929.508172132431;11273.323600583992;11302.830457543309;11445.942770286429;11686.70783230392;10057.597696092074;10258.113117776345;10265.281430300107;10281.023302786223;10594.894051059391;9252.092699768942;9499.572519236513;9514.571844267162;9702.320837541305;9937.801243975224 05:16:58 INFO - PROCESS | 7220 | __end_tp_report 05:16:58 INFO - PROCESS | 7220 | __start_cc_report 05:16:58 INFO - PROCESS | 7220 | _x_x_mozilla_cycle_collect,970 05:16:58 INFO - PROCESS | 7220 | __end_cc_report 05:16:58 INFO - PROCESS | 7220 | __startTimestamp1450963018637__endTimestamp 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | ------- Summary: start ------- 05:16:58 INFO - PROCESS | 7220 | Number of tests: 6 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | [#0] dojo.html Cycles:165 Average:5287.62 Median:5481.67 stddev:585.74 (10.7%) stddev-sans-first:562.10 05:16:58 INFO - PROCESS | 7220 | Values: 3111.0 3180.6 3190.7 3218.2 3252.8 5080.3 5204.2 5332.7 5352.1 5363.3 5248.1 5280.3 5291.3 5325.6 5389.5 4776.2 4799.8 4806.5 4846.9 4931.7 4856.5 4857.7 4873.8 4898.0 4955.6 4833.7 4872.6 4897.4 4899.7 4922.7 4806.6 4815.3 4818.4 4821.5 4845.4 4802.2 4803.3 4803.9 4810.8 4823.5 4985.4 5087.8 5165.6 5241.8 5263.7 5764.9 5783.2 5783.9 5789.0 5794.5 5507.7 5774.0 5780.9 5799.5 5801.2 5341.2 5356.9 5363.2 5402.8 5458.0 5855.6 5870.2 5902.9 5915.1 5961.0 5495.0 5672.3 5673.7 5675.3 5678.0 5481.7 5513.5 5523.9 5585.6 5659.5 5593.8 5605.6 5619.3 5629.1 5629.5 5500.2 5623.2 5624.7 5627.0 5633.0 4355.9 4370.5 4443.8 4483.2 4483.8 3958.3 3960.7 3966.9 3974.2 3995.0 5174.6 5315.6 5341.3 5342.3 5343.6 5715.3 5731.9 5755.7 5831.6 5850.0 5267.1 5268.9 5270.5 5272.9 5313.1 4748.6 4794.4 4795.8 4838.2 4842.2 5792.9 5880.5 5893.3 5895.0 5915.4 5735.8 5737.1 5739.8 5746.9 5760.9 5915.6 5917.2 5919.9 5926.0 5930.2 5457.8 5460.9 5575.7 5614.0 5646.1 5700.0 5730.3 5734.6 5737.4 5768.3 5610.1 5614.3 5614.9 5615.3 5622.2 5303.5 5467.7 5561.4 5635.5 5682.1 5520.3 5522.1 5524.4 5529.4 5531.4 5407.8 5601.7 5621.6 5641.8 5641.8 5420.7 5481.7 5483.9 5526.0 5544.1 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | [#1] ext.html Cycles:180 Average:49262.12 Median:18241.51 stddev:87796.87 (481.3%) stddev-sans-first:87966.95 05:16:58 INFO - PROCESS | 7220 | Values: 537.5 540.8 540.8 587.4 592.9 29507.0 30478.5 30490.2 30499.4 38544.2 42799.0 43810.0 43843.6 43874.7 43958.3 8766.3 8894.2 8921.9 8946.7 8950.6 7671.3 7865.1 8459.1 8524.5 10529.3 10413.7 10526.4 10530.3 10543.5 10544.6 10448.5 10498.7 10543.9 10549.8 10562.7 7657.7 7848.3 7853.7 10499.5 10803.2 39518.0 39786.6 39949.2 39986.6 40015.4 3267.7 3382.7 3430.7 3435.2 3440.6 27702.4 27726.0 27852.0 28045.4 28466.0 3789.5 3975.1 4009.0 4024.5 4048.2 272343.0 272756.0 273729.0 274083.6 274272.0 53927.7 54709.0 59297.4 59553.7 59616.0 70493.0 71640.0 72131.3 72230.3 72382.0 13745.1 14216.8 14253.6 14253.9 14254.6 9460.5 9617.3 10113.6 10423.6 10882.2 19959.2 20376.3 20389.2 20403.9 20472.4 8123.8 8165.3 8204.5 8297.6 8386.7 905.6 928.6 1113.1 1122.0 1122.3 28264.6 28307.7 28357.0 28664.0 28964.4 956.4 1012.8 1023.9 1060.9 1164.4 16381.7 16928.0 17115.0 17168.0 17172.0 393729.0 396019.0 400505.0 401862.0 401867.0 54433.7 54949.2 54954.0 54966.2 55133.7 1286.2 1299.3 1299.5 1312.4 1318.7 28687.3 29255.6 29357.7 29735.6 29762.6 41262.8 42069.8 42081.6 43754.6 44215.0 311516.0 315723.0 317916.0 317926.0 318278.0 29111.7 29277.4 29331.9 29536.3 29559.7 37632.6 38712.8 38965.0 39406.6 39456.8 32561.0 32758.5 33100.3 35702.7 36452.0 35183.0 36087.6 36353.0 36371.8 36544.8 34849.7 35111.6 35463.3 35586.5 35600.0 30830.8 32599.7 33032.8 33035.8 33077.7 21893.7 22138.7 22180.4 22208.6 22284.6 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | [#2] jquery.html Cycles:180 Average:27651.65 Median:17670.23 stddev:81968.20 (463.9%) stddev-sans-first:82172.50 05:16:58 INFO - PROCESS | 7220 | Values: 346.4 349.2 354.3 357.4 359.4 14013.9 14324.1 16170.2 16489.8 17254.7 14005.6 14163.6 14291.4 14295.3 14309.9 5262.1 5327.6 5442.6 5452.2 5465.8 3884.8 4003.7 5376.4 5824.9 5984.9 5903.2 5912.5 5913.8 5936.2 5950.6 5774.4 5884.6 5885.8 5893.4 5894.3 5195.9 5205.3 5229.0 5229.1 5229.3 20332.3 20717.5 20984.7 21149.3 21213.3 2129.3 2145.0 2156.5 2171.4 2190.1 13076.6 13300.7 13308.5 13384.1 13495.7 1767.8 1809.6 1831.3 1887.8 1891.3 59921.4 60717.0 60751.7 61126.7 63002.7 9498.0 9634.3 9836.1 9844.6 9895.0 12725.9 12739.3 12746.9 12755.9 12789.6 6723.7 6761.4 7011.8 7050.3 7086.2 6275.7 6296.9 6308.8 6334.1 6334.6 5954.9 5962.7 5973.3 5977.6 6017.6 1650.8 1733.5 1739.4 1747.2 1748.5 839.5 913.2 958.5 964.5 994.0 17266.9 17967.2 18128.9 18172.5 18322.3 938.9 944.9 981.0 999.8 1020.0 10305.7 10527.1 10608.0 10615.2 10621.3 485563.0 494165.0 503485.0 511506.0 512141.0 70678.2 78054.0 79898.0 82859.0 83413.6 1121.2 1135.2 1140.4 1176.3 1180.3 14684.5 15465.8 15550.4 15891.9 16255.8 34648.7 34991.3 35559.6 35730.6 36184.8 42046.6 42410.4 43300.6 43348.9 44311.8 9663.8 9818.1 9931.2 10054.1 10088.0 17155.0 17191.7 17328.8 17790.1 18340.7 10299.9 11083.3 11499.5 13215.0 14148.3 13162.7 13323.6 13719.0 14140.1 14538.6 11825.3 12084.3 13932.3 14344.0 14863.0 8502.4 8551.5 9282.0 9462.1 9465.6 10184.1 13793.0 14081.7 14331.1 14352.5 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | [#3] mootools.html Cycles:180 Average:5192.33 Median:5672.38 stddev:2681.03 (47.3%) stddev-sans-first:2672.14 05:16:58 INFO - PROCESS | 7220 | Values: 1245.6 1363.6 1371.1 1446.4 1550.1 6498.2 7099.0 7214.5 7236.5 7236.9 7460.4 7496.1 7546.4 7564.1 7588.9 1963.4 2005.0 2117.5 2153.8 2156.4 2241.9 2293.4 2294.2 2294.7 2296.6 2141.3 2165.6 2174.3 2184.4 2186.3 2144.4 2183.0 2206.9 2219.5 2244.7 2222.3 2247.8 2261.3 2271.1 2272.2 7399.6 7450.0 7455.7 7456.9 7468.7 4241.2 4331.4 4338.9 4343.3 4344.3 2923.3 2970.9 2998.6 3015.8 3031.7 1000.4 1001.4 1018.1 1034.6 1048.7 10122.1 10138.8 10153.3 10157.0 10170.5 4057.3 4091.7 4122.5 4158.0 4164.9 8702.7 8742.5 8747.7 8752.8 8761.1 4332.8 4338.6 4353.4 4360.8 4363.0 3930.8 3931.1 3932.1 3932.5 3934.0 3130.1 3306.8 3360.1 3439.4 3509.9 1114.9 1123.7 1136.6 1141.7 1163.4 1046.0 1064.2 1064.4 1076.9 1112.0 7169.9 7233.1 7237.1 7245.8 7250.1 1013.2 1013.3 1014.3 1041.3 1047.3 5594.8 5667.1 5667.9 5672.1 5672.7 8490.7 8606.6 8764.6 8767.7 8870.0 8697.4 8759.8 8789.0 8800.7 8803.8 6826.2 6930.1 6995.2 7044.4 7047.4 6797.0 6797.5 6825.3 6830.7 6835.3 7727.9 7783.9 8030.8 8046.2 8046.8 8002.7 8103.1 8118.0 8241.8 8260.8 6450.5 6527.0 6579.0 6610.2 6664.3 6433.0 6539.6 7144.7 7153.2 7207.8 5457.8 5558.0 6717.5 6857.3 6992.0 6722.3 6768.3 6777.9 6881.0 6885.3 6803.3 6861.4 6861.7 6877.8 6881.2 6285.4 6350.3 6350.7 6352.9 6354.1 6254.6 6283.5 6283.7 6305.0 6429.3 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | [#4] prototype.html Cycles:180 Average:5255.81 Median:5912.56 stddev:1579.80 (26.7%) stddev-sans-first:1540.47 05:16:58 INFO - PROCESS | 7220 | Values: 336.2 337.0 342.0 342.2 351.2 5877.8 5943.4 5945.7 5957.3 5959.4 5845.8 5853.3 5858.0 5859.3 5860.4 4579.9 4581.1 4585.7 4586.6 4589.5 4415.8 4520.3 4540.5 4544.9 4567.0 4513.4 4514.6 4521.4 4526.3 4526.5 4291.2 4377.9 4400.2 4526.0 4531.8 3934.8 3945.4 3961.2 3963.2 3967.6 5654.0 5655.5 5664.9 5669.2 5672.0 4992.1 5097.9 5106.2 5148.1 5256.3 6145.5 6206.4 6216.8 6230.3 6233.8 4360.2 4365.4 4366.5 4369.0 4373.3 6359.7 6444.8 6486.7 6510.2 6513.3 4483.8 4498.1 4500.8 4501.6 4506.7 4560.8 4561.2 4562.1 4562.4 4568.5 5230.7 5235.8 5242.1 5246.2 5251.2 6143.6 6273.5 6284.8 6288.9 6289.5 1589.8 1598.7 1601.6 1602.0 1602.8 1055.2 1072.8 1076.5 1089.2 1101.4 5903.2 5908.6 5916.5 5918.1 5920.2 6446.2 6448.1 6448.9 6451.0 6465.1 5860.6 5890.9 5902.6 5924.2 5934.2 3438.4 3517.9 3519.5 3520.1 3522.3 6760.7 6793.0 6802.3 6806.1 6806.1 6387.8 6552.2 6701.0 6704.4 6708.3 6600.6 6641.0 6666.9 6739.6 6749.7 6471.8 6533.3 6534.4 6535.4 6553.5 6325.6 6335.2 6432.1 6450.8 6465.4 6706.1 6755.2 6762.4 6763.4 6766.7 4499.1 4526.9 4543.9 4548.6 4549.3 6330.9 6543.2 6544.6 6553.8 6557.3 6308.6 6328.7 6329.6 6354.0 6362.5 6321.1 6327.5 6334.0 6337.0 6341.7 6101.3 6226.6 6226.6 6227.3 6239.4 6357.5 6366.6 6368.3 6373.0 6373.9 6181.6 6194.5 6202.0 6213.9 6220.7 05:16:58 INFO - PROCESS | 7220 | 05:16:58 INFO - PROCESS | 7220 | [#5] yui.html Cycles:180 Average:14148.29 Median:47958.14 stddev:16727.13 (34.9%) stddev-sans-first:16743.82 05:16:58 INFO - PROCESS | 7220 | Values: 756.0 766.5 772.9 792.5 808.0 13601.5 13835.8 13874.7 13880.3 13902.8 13233.6 13365.6 13384.5 13420.7 13429.0 681.9 689.1 717.5 729.7 814.0 829.6 833.1 837.1 837.9 839.6 869.9 876.7 877.5 878.4 878.9 697.6 706.1 850.5 866.2 866.3 637.6 637.8 638.5 641.2 641.3 12797.3 12951.8 12961.2 12977.3 13001.6 11392.3 11703.9 11787.6 12070.7 12173.1 10199.2 10227.4 10467.3 10760.9 10921.6 3540.2 3574.6 3599.8 3603.5 3616.3 50088.2 50533.2 50838.5 50884.0 50974.0 9054.7 9082.6 9110.1 9151.2 9682.5 16471.4 16692.9 16694.2 16718.2 16728.0 6660.8 6759.0 6773.3 6845.3 6870.4 4133.6 4175.4 4181.4 4193.6 4267.1 2780.2 2802.1 2802.5 2802.6 2804.7 525.5 550.3 556.2 561.0 562.9 523.3 587.7 614.3 617.3 685.9 9071.8 9129.4 9165.4 9256.1 9349.7 587.7 625.4 643.2 643.8 663.8 3950.5 4086.3 4142.2 4158.2 4178.6 56850.0 61883.0 62341.0 62410.4 62433.4 49996.8 50633.7 51519.5 52233.7 52444.7 47794.3 48122.0 48319.3 48453.3 49262.5 8945.6 9018.5 9160.4 9161.8 9216.9 36947.6 36971.3 37342.6 37549.8 38582.0 46063.5 46856.8 47088.3 47205.0 47622.0 11174.3 11286.3 11319.4 11418.7 12046.0 12007.4 12010.9 12070.6 12078.9 13109.2 11758.4 11953.3 12249.5 12272.4 12305.3 11429.3 11608.9 11622.7 11996.7 12024.6 10929.5 11273.3 11302.8 11445.9 11686.7 10057.6 10258.1 10265.3 10281.0 10594.9 9252.1 9499.6 9514.6 9702.3 9937.8 05:16:58 INFO - PROCESS | 7220 | -------- Summary: end -------- 05:16:58 INFO - PROCESS | 7220 | 05:16:59 INFO - TEST-INFO | 7220: exit 0 05:16:59 INFO - TEST-OK | dromaeo_css | took 1112898ms 05:16:59 INFO - TEST-START | kraken 05:16:59 INFO - operating with platform_type : linux_ 05:16:59 INFO - Initialising browser for kraken test... 05:16:59 INFO - TEST-INFO | started process 7410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWBP68m/profile http://localhost:57500/getInfo.html) 05:17:03 INFO - PROCESS | 7410 | __metrics Screen width/height:1600/1200 05:17:03 INFO - PROCESS | 7410 | colorDepth:24 05:17:03 INFO - PROCESS | 7410 | Browser inner width/height: 1024/697 05:17:03 INFO - PROCESS | 7410 | __metrics 05:17:03 INFO - PROCESS | 7410 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:17:03 INFO - PROCESS | 7410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:03 ERROR - PROCESS | 7410 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:17:04 INFO - TEST-INFO | 7410: exit 0 05:17:04 INFO - Browser initialized. 05:17:04 INFO - Running cycle 1/1 for kraken test... 05:17:04 INFO - TEST-INFO | started process 7499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWBP68m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:16 INFO - PROCESS | 7499 | RSS: Main: 150114304 05:17:16 INFO - PROCESS | 7499 | 05:17:19 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:19 INFO - PROCESS | 7499 | RSS: Main: 185044992 05:17:19 INFO - PROCESS | 7499 | 05:17:22 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-dft) 05:17:22 INFO - PROCESS | 7499 | RSS: Main: 175013888 05:17:22 INFO - PROCESS | 7499 | 05:17:25 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-fft) 05:17:26 INFO - PROCESS | 7499 | RSS: Main: 161079296 05:17:26 INFO - PROCESS | 7499 | 05:17:28 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57500/tests/kraken/driver.html?testName=audio-oscillator) 05:17:28 INFO - PROCESS | 7499 | RSS: Main: 162242560 05:17:28 INFO - PROCESS | 7499 | 05:17:31 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:31 INFO - PROCESS | 7499 | RSS: Main: 163655680 05:17:31 INFO - PROCESS | 7499 | 05:17:34 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57500/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:35 INFO - PROCESS | 7499 | RSS: Main: 164515840 05:17:35 INFO - PROCESS | 7499 | 05:17:38 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57500/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:39 INFO - PROCESS | 7499 | RSS: Main: 166535168 05:17:39 INFO - PROCESS | 7499 | 05:17:41 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57500/tests/kraken/driver.html?testName=json-parse-financial) 05:17:42 INFO - PROCESS | 7499 | RSS: Main: 164368384 05:17:42 INFO - PROCESS | 7499 | 05:17:43 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:44 INFO - PROCESS | 7499 | RSS: Main: 173330432 05:17:44 INFO - PROCESS | 7499 | 05:17:46 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:46 INFO - PROCESS | 7499 | RSS: Main: 171282432 05:17:46 INFO - PROCESS | 7499 | 05:17:48 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:49 INFO - PROCESS | 7499 | RSS: Main: 185679872 05:17:49 INFO - PROCESS | 7499 | 05:17:51 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:52 INFO - PROCESS | 7499 | RSS: Main: 193404928 05:17:52 INFO - PROCESS | 7499 | 05:17:55 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:55 INFO - PROCESS | 7499 | RSS: Main: 191090688 05:17:55 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | Cycle 1(1): loaded http://localhost:57500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57500/tests/kraken/driver.html?testName=ai-astar) 05:17:57 INFO - PROCESS | 7499 | RSS: Main: 250265600 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | __start_tp_report 05:17:57 INFO - PROCESS | 7499 | _x_x_mozilla_page_load 05:17:57 INFO - PROCESS | 7499 | _x_x_mozilla_page_load_details 05:17:57 INFO - PROCESS | 7499 | |i|pagename|runs| 05:17:57 INFO - PROCESS | 7499 | |0;ai-astar;110;110;105;110;111;110;101;112;111;110 05:17:57 INFO - PROCESS | 7499 | |1;audio-beat-detection;144;122;149;161;128;152;151;124;164;125 05:17:57 INFO - PROCESS | 7499 | |2;audio-dft;161;161;162;160;163;162;162;164;161;163 05:17:57 INFO - PROCESS | 7499 | |3;audio-fft;71;72;87;90;71;72;73;127;89;71 05:17:57 INFO - PROCESS | 7499 | |4;audio-oscillator;93;93;138;92;94;94;138;93;94;135 05:17:57 INFO - PROCESS | 7499 | |5;imaging-gaussian-blur;109;109;110;110;109;110;110;109;110;109 05:17:57 INFO - PROCESS | 7499 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;147;146 05:17:57 INFO - PROCESS | 7499 | |7;imaging-desaturate;96;96;95;96;97;96;96;96;96;96 05:17:57 INFO - PROCESS | 7499 | |8;json-parse-financial;61;59;57;58;57;58;59;66;56;56 05:17:57 INFO - PROCESS | 7499 | |9;json-stringify-tinderbox;66;67;66;66;67;67;67;68;68;68 05:17:57 INFO - PROCESS | 7499 | |10;stanford-crypto-aes;90;84;83;91;84;85;84;83;85;84 05:17:57 INFO - PROCESS | 7499 | |11;stanford-crypto-ccm;116;119;123;124;115;122;118;116;117;115 05:17:57 INFO - PROCESS | 7499 | |12;stanford-crypto-pbkdf2;143;149;156;151;152;143;150;149;155;138 05:17:57 INFO - PROCESS | 7499 | |13;stanford-crypto-sha256-iterative;69;71;68;68;68;69;67;68;67;68 05:17:57 INFO - PROCESS | 7499 | __end_tp_report 05:17:57 INFO - PROCESS | 7499 | __start_cc_report 05:17:57 INFO - PROCESS | 7499 | _x_x_mozilla_cycle_collect,927 05:17:57 INFO - PROCESS | 7499 | __end_cc_report 05:17:57 INFO - PROCESS | 7499 | __startTimestamp1450963077559__endTimestamp 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | ------- Summary: start ------- 05:17:57 INFO - PROCESS | 7499 | Number of tests: 14 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:3.55 05:17:57 INFO - PROCESS | 7499 | Values: 110.0 110.0 105.0 110.0 111.0 110.0 101.0 112.0 111.0 110.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:150.00 stddev:15.94 (10.6%) stddev-sans-first:16.90 05:17:57 INFO - PROCESS | 7499 | Values: 144.0 122.0 149.0 161.0 128.0 152.0 151.0 124.0 164.0 125.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 05:17:57 INFO - PROCESS | 7499 | Values: 161.0 161.0 162.0 160.0 163.0 162.0 162.0 164.0 161.0 163.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#3] audio-fft Cycles:10 Average:82.30 Median:72.50 stddev:17.66 (24.4%) stddev-sans-first:18.25 05:17:57 INFO - PROCESS | 7499 | Values: 71.0 72.0 87.0 90.0 71.0 72.0 73.0 127.0 89.0 71.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.00 stddev:21.14 (22.7%) stddev-sans-first:21.86 05:17:57 INFO - PROCESS | 7499 | Values: 93.0 93.0 138.0 92.0 94.0 94.0 138.0 93.0 94.0 135.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:17:57 INFO - PROCESS | 7499 | Values: 109.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 05:17:57 INFO - PROCESS | 7499 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:17:57 INFO - PROCESS | 7499 | Values: 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.50 stddev:2.98 (5.1%) stddev-sans-first:3.05 05:17:57 INFO - PROCESS | 7499 | Values: 61.0 59.0 57.0 58.0 57.0 58.0 59.0 66.0 56.0 56.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 05:17:57 INFO - PROCESS | 7499 | Values: 66.0 67.0 66.0 66.0 67.0 67.0 67.0 68.0 68.0 68.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.50 stddev:2.83 (3.3%) stddev-sans-first:2.44 05:17:57 INFO - PROCESS | 7499 | Values: 90.0 84.0 83.0 91.0 84.0 85.0 84.0 83.0 85.0 84.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:118.50 stddev:3.37 (2.8%) stddev-sans-first:3.46 05:17:57 INFO - PROCESS | 7499 | Values: 116.0 119.0 123.0 124.0 115.0 122.0 118.0 116.0 117.0 115.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:150.50 stddev:5.68 (3.8%) stddev-sans-first:5.65 05:17:57 INFO - PROCESS | 7499 | Values: 143.0 149.0 156.0 151.0 152.0 143.0 150.0 149.0 155.0 138.0 05:17:57 INFO - PROCESS | 7499 | 05:17:57 INFO - PROCESS | 7499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 05:17:57 INFO - PROCESS | 7499 | Values: 69.0 71.0 68.0 68.0 68.0 69.0 67.0 68.0 67.0 68.0 05:17:57 INFO - PROCESS | 7499 | -------- Summary: end -------- 05:17:57 INFO - PROCESS | 7499 | 05:17:58 INFO - TEST-INFO | 7499: exit 0 05:17:58 INFO - TEST-OK | kraken | took 59313ms 05:17:58 INFO - TEST-START | v8_7 05:17:58 INFO - operating with platform_type : linux_ 05:17:58 INFO - Initialising browser for v8_7 test... 05:17:58 INFO - TEST-INFO | started process 7751 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5yym8V/profile http://localhost:57500/getInfo.html) 05:18:02 INFO - PROCESS | 7751 | __metrics Screen width/height:1600/1200 05:18:02 INFO - PROCESS | 7751 | colorDepth:24 05:18:02 INFO - PROCESS | 7751 | Browser inner width/height: 1024/697 05:18:02 INFO - PROCESS | 7751 | __metrics 05:18:03 INFO - PROCESS | 7751 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:18:03 INFO - PROCESS | 7751 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:03 INFO - TEST-INFO | 7751: exit 0 05:18:03 INFO - Browser initialized. 05:18:03 INFO - Running cycle 1/1 for v8_7 test... 05:18:03 INFO - TEST-INFO | started process 7834 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5yym8V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:15 INFO - PROCESS | 7834 | RSS: Main: 149852160 05:18:15 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | Cycle 1(1): loaded http://localhost:57500/tests/v8_7/run.html (next: http://localhost:57500/tests/v8_7/run.html) 05:18:37 INFO - PROCESS | 7834 | RSS: Main: 620949504 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | __start_tp_report 05:18:37 INFO - PROCESS | 7834 | _x_x_mozilla_page_load 05:18:37 INFO - PROCESS | 7834 | _x_x_mozilla_page_load_details 05:18:37 INFO - PROCESS | 7834 | |i|pagename|runs| 05:18:37 INFO - PROCESS | 7834 | |0;Richards;166.27868307283006 05:18:37 INFO - PROCESS | 7834 | |1;DeltaBlue;191.46084625694044 05:18:37 INFO - PROCESS | 7834 | |2;Encrypt;279.9552071668533 05:18:37 INFO - PROCESS | 7834 | |3;Decrypt;5143.589743589743 05:18:37 INFO - PROCESS | 7834 | |4;RayTrace;1104.9723756906078 05:18:37 INFO - PROCESS | 7834 | |5;Earley;780.64012490242 05:18:37 INFO - PROCESS | 7834 | |6;Boyer;12382.716049382716 05:18:37 INFO - PROCESS | 7834 | |7;RegExp;25575 05:18:37 INFO - PROCESS | 7834 | |8;Splay;694.4444444444445 05:18:37 INFO - PROCESS | 7834 | |9;NavierStokes;4826.923076923077 05:18:37 INFO - PROCESS | 7834 | __end_tp_report 05:18:37 INFO - PROCESS | 7834 | __startTimestamp1450963117415__endTimestamp 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | ------- Summary: start ------- 05:18:37 INFO - PROCESS | 7834 | Number of tests: 10 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 166.3 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#1] DeltaBlue Cycles:1 Average:191.46 Median:191.46 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 191.5 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 280.0 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 5143.6 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 1105.0 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 780.6 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 12382.7 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 25575.0 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#8] Splay Cycles:1 Average:694.44 Median:694.44 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 694.4 05:18:37 INFO - PROCESS | 7834 | 05:18:37 INFO - PROCESS | 7834 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:18:37 INFO - PROCESS | 7834 | Values: 4826.9 05:18:37 INFO - PROCESS | 7834 | -------- Summary: end -------- 05:18:37 INFO - PROCESS | 7834 | 05:18:38 INFO - TEST-INFO | 7834: exit 0 05:18:38 INFO - TEST-OK | v8_7 | took 39727ms 05:18:38 INFO - SUITE-END | took 1211s 05:18:38 INFO - Completed test suite (00:20:11) 05:18:38 INFO - Working with test: dromaeo_css 05:18:38 INFO - Generating results file: dromaeo_css 05:18:38 INFO - Working with test: kraken 05:18:38 INFO - Generating results file: kraken 05:18:38 INFO - javascript benchmark 05:18:38 INFO - Working with test: v8_7 05:18:38 INFO - Generating results file: v8_7 05:18:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:18:38 INFO - process_Request line: dromaeo_css 6927.80 graph.html#tests=[[72,201,35]] 05:18:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:38 INFO - process_Request line: kraken 1499.50 graph.html#tests=[[232,201,35]] 05:18:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:38 INFO - process_Request line: v8_7 20757.53 graph.html#tests=[[230,201,35]] 05:18:38 INFO - RETURN: dromaeo_css: 6927.80 05:18:38 INFO - RETURN: kraken: 1499.50 05:18:38 INFO - RETURN: v8_7: 20757.53 05:18:38 INFO - javascript benchmark 05:18:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.984445077774, 3180.586523751912, 3190.69688379604, 3218.163277547837, 3252.788568743032, 5080.314157588725, 5204.245384419266, 5332.733363331832, 5352.116900711383, 5363.275957745708, 5248.0815857225025, 5280.313559237304, 5291.259223708684, 5325.600579956509, 5389.541888939435, 4776.188048031843, 4799.784009719571, 4806.543378379057, 4846.927296090562, 4931.679440836352, 4856.514348565151, 4857.73282469464, 4873.756312184394, 4898.0, 4955.628327875405, 4833.685810422311, 4872.561469467747, 4897.436794768611, 4899.681520701179, 4922.729249891255, 4806.639502037327, 4815.3258543803895, 4818.445878723956, 4821.493743156988, 4845.41854977405, 4802.207635740098, 4803.3035209894715, 4803.855884323476, 4810.807567697288, 4823.541763532458, 4985.426675932278, 5087.821926232601, 5165.612579056548, 5241.764120614582, 5263.710495922723, 5764.855878603026, 5783.190353350535, 5783.942160578383, 5788.97105514474, 5794.536437085023, 5507.697076660782, 5774.0, 5780.942190578083, 5799.536037117021, 5801.187833703285, 5341.225522299244, 5356.946430535722, 5363.19552067193, 5402.837914862561, 5458.0, 5855.560832937546, 5870.207521984563, 5902.8819423611285, 5915.08316210988, 5960.970195149083, 5495.0, 5672.290963629546, 5673.687947162945, 5675.262215911905, 5678.034734095214, 5481.671099734029, 5513.476219759116, 5523.917141242885, 5585.581081418829, 5659.490645841894, 5593.8321850344555, 5605.635633683797, 5619.269494965628, 5629.127485239795, 5629.549636029108, 5500.1749737539685, 5623.156526521055, 5624.746886390122, 5626.971865140648, 5633.042382794934, 4355.891102722458, 4370.519242883281, 4443.777811109431, 4483.170613436525, 4483.798229079699, 3958.3072962232072, 3960.7227494075714, 3966.940495892564, 3974.2448934702893, 3994.960050399459, 5174.560162386239, 5315.6013299002725, 5341.252224688546, 5342.332208473941, 5343.599230057761, 5715.2855893013375, 5731.914021289684, 5755.6834374108985, 5831.62094463867, 5849.970750146222, 5267.1309233976735, 5268.947310526923, 5270.525652691276, 5272.92090618641, 5313.123334649817, 4748.572628463386, 4794.352762377034, 4795.808167673324, 4838.225883858636, 4842.249451335048, 5792.855178620568, 5880.529557635465, 5893.263342082239, 5894.970525147347, 5915.37888521699, 5735.827925162252, 5737.139429085503, 5739.827805165852, 5746.856328591652, 5760.913586296293, 5915.58590898633, 5917.230760001173, 5919.91120133207, 5925.970370148121, 5930.199423077829, 5457.781688732406, 5460.945390546044, 5575.749091290821, 5613.961417137843, 5646.096624540054, 5699.971500142473, 5730.255066841284, 5734.598578099493, 5737.426257374229, 5768.307803063659, 5610.13042978339, 5614.326280846324, 5614.887702246014, 5615.2700148980375, 5622.156676498558, 5303.46965303482, 5467.699276539828, 5561.360443549043, 5635.464630860061, 5682.119271512922, 5520.254765606753, 5522.144067669517, 5524.447555244444, 5529.364123125731, 5531.419200983839, 5407.783688652567, 5601.747921343631, 5621.578381621313, 5641.774329026793, 5641.830745077655, 5420.7289635518855, 5481.671099734029, 5483.917741233964, 5526.0, 5544.0575102231915], "unit": "score", "name": "dojo.html", "value": 5250.030512453391}, {"lowerIsBetter": false, "replicates": [537.4544836990455, 540.7755781350739, 540.8080131553298, 587.4067192135941, 592.8784599157174, 29507.0, 30478.54282185769, 30490.237744056383, 30499.390012199743, 38544.22911541768, 42799.0, 43810.0, 43843.56156438435, 43874.735031796146, 43958.340624890654, 8766.342524310687, 8894.199522043014, 8921.866172007425, 8946.731598052036, 8950.597223124942, 7671.347935425468, 7865.056193256817, 8459.069502354736, 8524.488530688148, 10529.315594486372, 10413.687589372332, 10526.42104684242, 10530.315529490597, 10543.47282635869, 10544.630937917174, 10448.529816158252, 10498.737531561696, 10543.894561054369, 10549.78900421991, 10562.735931601695, 7657.65540550671, 7848.254415830487, 7853.725119620786, 10499.527521261562, 10803.189760767895, 39518.0, 39786.60213397858, 39949.20101597981, 39986.60013399858, 40015.39976900349, 3267.7059064684295, 3382.678645528671, 3430.7255419566377, 3435.209901722618, 3440.55272814535, 27702.445951081067, 27726.0, 27852.0, 28045.43909121806, 28466.0, 3789.5263092113487, 3975.1453437510786, 4009.0, 4024.476818013669, 4048.1701251243426, 272343.0, 272756.0, 273729.0, 274083.6295818528, 274272.0, 53927.730361347945, 54709.0, 59297.40702593005, 59553.70223148856, 59616.0, 70493.0, 71640.0, 72131.27868721246, 72230.27769722341, 72382.0, 13745.106568073043, 14216.786748198785, 14253.643658908402, 14253.928730356489, 14254.572362829133, 9460.47967361788, 9617.326787124974, 10113.59545618167, 10423.583056677648, 10882.183836212316, 19959.20163193456, 20376.28682996088, 20389.184432622827, 20403.897980510003, 20472.385828425173, 8123.83752324962, 8165.345752920897, 8204.466709663853, 8297.626606802709, 8386.706465273808, 905.6467977488785, 928.6007016982762, 1113.124770987448, 1121.9831702524468, 1122.259308856151, 28264.576031359546, 28307.71692283092, 28357.0, 28664.0, 28964.42071158607, 956.4213650741341, 1012.7670635753818, 1023.9078482936422, 1060.9151267898549, 1164.3654208456412, 16381.67236655284, 16928.0, 17115.0, 17168.0, 17172.0, 393729.0, 396019.0, 400505.0, 401862.0, 401867.0, 54433.72783136059, 54949.17576236359, 54954.0, 54966.17550736742, 55133.724331378886, 1286.2218357893528, 1299.2983788753968, 1299.4607237996315, 1312.3831799054428, 1318.6835159561635, 28687.282817929718, 29255.561166582094, 29357.7064229355, 29735.553966690084, 29762.553561697026, 41262.79368603138, 42069.79302069891, 42081.57918420777, 43754.56245437632, 44215.0, 311516.0, 315723.0, 317916.0, 317926.0, 318278.0, 29111.708882910898, 29277.41445171042, 29331.85334073316, 29536.261593460335, 29559.704402956555, 37632.62367376401, 38712.80643596764, 38965.0, 39406.60593394144, 39456.80271598624, 32561.0, 32758.508622370206, 33100.33799323952, 35702.71425305921, 36452.0, 35183.0, 36087.63912360843, 36353.0, 36371.81814090913, 36544.817275914516, 34849.65150348464, 35111.64888351084, 35463.290734185684, 35586.46620300749, 35600.0, 30830.84584577063, 32599.674003260614, 33032.83483582567, 33035.834820825745, 33077.66922330746, 21893.671594926407, 22138.667919981537, 22180.445488862908, 22208.555828883655, 22284.554308914056], "unit": "score", "name": "ext.html", "value": 18602.526754418897}, {"lowerIsBetter": false, "replicates": [346.37306475279746, 349.1654944682209, 354.2595974413477, 357.4227622389841, 359.4410691374914, 14013.92993035036, 14324.068935519184, 16170.191490425475, 16489.752653710188, 17254.654906901855, 14005.649858753537, 14163.575092747209, 14291.356888939996, 14295.285235738198, 14309.928450357733, 5262.131748261542, 5327.600429967749, 5442.591805614575, 5452.154915988028, 5465.781368745265, 3884.766913985156, 4003.719739618228, 5376.354837419515, 5824.854378640547, 5984.910226346608, 5903.173555702184, 5912.467877890989, 5913.793017244398, 5936.198613187229, 5950.55370847186, 5774.364819869811, 5884.617499862538, 5885.823425297248, 5893.351731309574, 5894.292684877821, 5195.882885179667, 5205.27126202332, 5229.0, 5229.111051121318, 5229.294045303874, 20332.288369906983, 20717.482062948548, 20984.685229721566, 21149.25977590777, 21213.257535986166, 2129.2654034358275, 2144.9571008579896, 2156.5363446859, 2171.4354267890303, 2190.1348967157883, 13076.607701768962, 13300.73398532024, 13308.467661293633, 13384.130031548015, 13495.66260843477, 1767.814379490148, 1809.6290260496567, 1831.3498707958615, 1887.8395336396422, 1891.2624076610134, 59921.40078599202, 60717.0, 60751.69624151851, 61126.694366528325, 63002.68498657523, 9497.952510237405, 9634.277429192838, 9836.114749672564, 9844.60621575129, 9895.0, 12725.93637031809, 12739.29933853647, 12746.872531274754, 12755.87244127547, 12789.61631151067, 6723.731050757915, 6761.425278851254, 7011.824704382431, 7050.294970503011, 7086.185088714864, 6275.748970041239, 6296.905546416808, 6308.842278943063, 6334.113224148623, 6334.5565810393755, 5954.940450595439, 5962.731677074542, 5973.253343332083, 5977.551683623746, 6017.585867321176, 1650.7949197086195, 1733.4972857871076, 1739.443378119015, 1747.1788259518007, 1748.5104170832187, 839.4585492357395, 913.1553313185277, 958.5063692198523, 964.5225613321311, 993.9602415903283, 17266.913665431843, 17967.191476383596, 18128.90935545314, 18172.45482635523, 18322.267109315744, 938.8920274168559, 944.9102335278137, 981.0434826044692, 999.7850462150527, 1020.0156848640949, 10305.74235644115, 10527.052565269008, 10608.0, 10615.203859710553, 10621.309614875008, 485563.0, 494165.0, 503484.96515034384, 511506.0, 512141.0, 70678.18320466061, 78054.0, 79898.0, 82859.0, 83413.58293208617, 1121.1703339528854, 1135.211028335299, 1140.3784937209075, 1176.311857563318, 1180.3213152437384, 14684.486042988445, 15465.768013479581, 15550.377984880479, 15891.920540397225, 16255.837441625432, 34648.653513464546, 34991.30017399587, 35559.64440355667, 35730.64269357377, 36184.81907590445, 42046.57953420427, 42410.36384454174, 43300.56699432965, 43348.916277093325, 44311.778441107585, 9663.806723865624, 9818.116369526777, 9931.155851752683, 10054.095131438205, 10088.0, 17155.0, 17191.7421238679, 17328.82671173272, 17790.110494475484, 18340.724889126406, 10299.897001029894, 11083.33499989971, 11499.54001839917, 13215.0, 14148.292585370484, 13162.670933226746, 13323.600291991255, 13719.0, 14140.080894741808, 14538.563843084725, 11825.290482571074, 12084.335361555199, 13932.30338483092, 14344.0, 14863.0, 8502.36232282569, 8551.486910785372, 9282.0, 9462.101100395726, 9465.574049167666, 10184.083432491112, 13793.0, 14081.718365632425, 14331.140131592138, 14352.49766258176], "unit": "score", "name": "jquery.html", "value": 8859.560456790614}, {"lowerIsBetter": false, "replicates": [1245.613859703492, 1363.6181869076656, 1371.1430356027483, 1446.3708286895194, 1550.0699580251844, 6498.187726534184, 7099.041629380039, 7214.494985351028, 7236.529625574347, 7236.927630723691, 7460.440466964972, 7496.062992125984, 7546.358559522447, 7564.130125035623, 7588.9241107588905, 1963.3520938090467, 2004.9699254511122, 2117.470632341918, 2153.816925561321, 2156.3962090614573, 2241.9103235870625, 2293.4266433391654, 2294.231432470116, 2294.724633044037, 2296.5636529059507, 2141.2612648636273, 2165.5560610074895, 2174.3042226487532, 2184.43204766761, 2186.3440967709703, 2144.378130342199, 2182.9890850545644, 2206.856554323964, 2219.511707424372, 2244.7418546867157, 2222.3221917315213, 2247.763984781591, 2261.2650888461317, 2271.102914348823, 2272.227442669484, 7399.593022383767, 7450.0, 7455.739049133309, 7456.888146677804, 7468.738594149233, 4241.151769646083, 4331.436913201295, 4338.891527711801, 4343.283358245917, 4344.304911214223, 2923.313021439981, 2970.925726856846, 2998.625171853518, 3015.834129122897, 3031.7271445570004, 1000.3997601439152, 1001.3591301567003, 1018.1244130048152, 1034.6223628375665, 1048.7378155461136, 10122.139618132467, 10138.847917281246, 10153.340032897911, 10157.0, 10170.491475426274, 4057.330540460791, 4091.652209562161, 4122.505299364096, 4158.022864626811, 4164.875053748392, 8702.738917832476, 8742.519161446182, 8747.737567872973, 8752.824943501095, 8761.123887611187, 4332.848350307724, 4338.6312163466455, 4353.36876152956, 4360.825566977349, 4363.0, 3930.8231129598666, 3931.0761970936805, 3932.075962148893, 3932.5477570079806, 3933.9606603934167, 3130.139211716796, 3306.834658267077, 3360.1095709636966, 3439.3637177122314, 3509.9122521936647, 1114.899659030675, 1123.6685177872548, 1136.602189233778, 1141.7431078007548, 1163.4299193395175, 1045.9581616735397, 1064.2337516987757, 1064.4411683866033, 1076.9461526923778, 1112.0491979357694, 7169.928300717031, 7233.132024157135, 7237.095363079615, 7245.7826265212125, 7250.093738282715, 1013.159077965287, 1013.310948554975, 1014.2899970021015, 1041.265907535186, 1047.2826114111706, 5594.832155035356, 5667.093265077568, 5667.886642267132, 5672.09246520563, 5672.659640421588, 8490.745277641681, 8606.612702428405, 8764.56177191138, 8767.693130740394, 8869.955650221837, 8697.391182617155, 8759.781005474786, 8788.95605521981, 8800.735977920673, 8803.823923521622, 6826.180858297036, 6930.13373328334, 6995.230524642387, 7044.366007059287, 7047.40097091753, 6796.96601517009, 6797.524173307821, 6825.317468253135, 6830.726770929107, 6835.282295358916, 7727.884081738891, 7783.92216077832, 8030.799230019296, 8046.235607617267, 8046.798830029296, 8002.717187710691, 8103.0681471631515, 8118.0, 8241.752747417588, 8260.793480163044, 6450.48396128318, 6527.0, 6579.046038324512, 6610.2398224204835, 6664.333566643297, 6432.9678351607945, 6539.6403197824575, 7144.749933752294, 7153.2131465537705, 7207.783766487014, 5457.808976685797, 5558.0, 6717.462602991651, 6857.27998560164, 6991.965040174767, 6722.327767223434, 6768.289329620319, 6777.93222067773, 6881.036654868422, 6885.277045910308, 6803.285655006153, 6861.421872969146, 6861.656917154222, 6877.759278425231, 6881.174259088942, 6285.397223707925, 6350.333215012542, 6350.714217860115, 6352.9047064293145, 6354.078658594385, 6254.593451425642, 6283.5287353449585, 6283.71723272463, 6305.0, 6429.260635027032], "unit": "score", "name": "mootools.html", "value": 4270.629331634625}, {"lowerIsBetter": false, "replicates": [336.2451296838598, 337.0, 341.9521267022616, 342.16170382562717, 351.19225780704375, 5877.764889404424, 5943.375945525722, 5945.672987985665, 5957.2851257849115, 5959.374265702104, 5845.824625261238, 5853.268341457318, 5857.970710146444, 5859.296884373871, 5860.443257890493, 4579.885502862422, 4581.083783243364, 4585.656075794321, 4586.610138138262, 4589.518100599439, 4415.845445409412, 4520.254158063915, 4540.545945405466, 4544.863654090383, 4566.97716511417, 4513.390692256553, 4514.616257618107, 4521.434820647419, 4526.3210518422175, 4526.479454862683, 4291.249031419505, 4377.912441751179, 4400.163968845909, 4525.9547404525865, 4531.773411329436, 3934.7639141651593, 3945.4279129526058, 3961.227560625679, 3963.2271707017144, 3967.6230758077936, 5653.971730141364, 5655.491005809456, 5664.85837854057, 5669.206311116447, 5671.9716401418145, 4992.076465853828, 5097.949020509822, 5106.183010718267, 5148.073346797575, 5256.26412302278, 6145.539084568631, 6206.4173635723055, 6216.751329946796, 6230.2523697156175, 6233.844153896189, 4360.21516127097, 4365.43249377582, 4366.497852746911, 4368.978155109204, 4373.2565463871215, 6359.682015899187, 6444.8388790280615, 6486.708098135595, 6510.21877374718, 6513.2509761377105, 4483.843065492757, 4498.077894031716, 4500.819967201275, 4501.572350626685, 4506.662000349921, 4560.840370587013, 4561.2473941799235, 4562.133194692998, 4562.403158894361, 4568.520305367955, 5230.686158830483, 5235.848113415119, 5242.082635538842, 5246.213068039749, 5251.238570407269, 6143.631382116998, 6273.498120150377, 6284.780032698834, 6288.937110628926, 6289.465395441347, 1589.8410158984009, 1598.7202239608023, 1601.591594143486, 1601.9519414417587, 1602.8156761972289, 1055.1611468882256, 1072.822984207597, 1076.4510099849133, 1089.1722291058852, 1101.3502033800096, 5903.173555702205, 5908.645481271137, 5916.467517923407, 5918.141869428995, 5920.171176035358, 6446.194225721785, 6448.129502517194, 6448.935510644834, 6451.000094985285, 6465.127207826978, 5860.619059761102, 5890.8821823563285, 5902.61632993854, 5924.229850119457, 5934.1692163097205, 3438.432658611301, 3517.894463166058, 3519.5424594803026, 3520.119970007498, 3522.2955408917805, 6760.661966901635, 6793.048973143764, 6802.319768023257, 6806.149231346082, 6806.149231346082, 6387.776427825004, 6552.213734351908, 6701.0, 6704.363085506869, 6708.262091169968, 6600.636964966973, 6640.966795165993, 6666.933330666729, 6739.629320387327, 6749.730010799612, 6471.805845824632, 6533.346665333429, 6534.444572211225, 6535.44448721864, 6553.5084868635995, 6325.6204627720645, 6335.239771227482, 6432.09950606906, 6450.8064758057335, 6465.3857883501, 6706.0611514389, 6755.2231493378895, 6762.357576030269, 6763.357481039294, 6766.729330826712, 4499.122671079239, 4526.932096018497, 4543.863684089482, 4548.5906268436, 4549.3176023596725, 6330.936690633219, 6543.247526534319, 6544.574602650812, 6553.770618028346, 6557.311482294291, 6308.589941653778, 6328.746850126127, 6329.588576742497, 6353.983362661952, 6362.522810789117, 6321.051842223703, 6327.462165715966, 6333.96833015832, 6337.049442583465, 6341.682915854097, 6101.328853825987, 6226.59527130735, 6226.62640241587, 6227.252729672468, 6239.438450539473, 6357.4596159326975, 6366.586171898997, 6368.267649220214, 6373.0, 6373.936260637334, 6181.567290289637, 6194.473469755121, 6202.0, 6213.850437669045, 6220.688965551795], "unit": "score", "name": "prototype.html", "value": 4746.06707057103}, {"lowerIsBetter": false, "replicates": [756.0285033731652, 766.5132640773107, 772.8647486689829, 792.4690457393546, 808.0303635637237, 13601.52394666187, 13835.792463113048, 13874.653133671663, 13880.305984700775, 13902.791458128137, 13233.602991910235, 13365.599032029031, 13384.464621415133, 13420.731585368287, 13429.0, 681.924988251292, 689.1007235557595, 717.5264325545141, 729.6752944939477, 813.9552324622143, 829.5976451421056, 833.0794472108294, 837.1335667584052, 837.9162083791603, 839.5760141128721, 869.9173578510031, 876.7325965580495, 877.4998250996935, 878.3895192840978, 878.8505953987806, 697.5709938387905, 706.0750416953807, 850.544958447234, 866.2204016385241, 866.2982983783156, 637.6206157336377, 637.8182218067828, 638.4923985431593, 641.1600802948153, 641.2593454559991, 12797.296148711817, 12951.805722914163, 12961.157524760954, 12977.286249256287, 13001.60995170137, 11392.316461012282, 11703.882961170364, 11787.587434439753, 12070.69823254417, 12173.08701847365, 10199.235057370654, 10227.43749093807, 10467.267291289612, 10760.892391076068, 10921.617743379024, 3540.150363912642, 3574.6067932527403, 3599.8200089995657, 3603.513525674027, 3616.258666973264, 50088.24867626988, 50533.24200137001, 50838.491615083745, 50884.0, 50974.0, 9054.728358149267, 9082.636694532277, 9110.134537218953, 9151.17639412456, 9682.515874206261, 16471.423500177676, 16692.916535417244, 16694.165291735364, 16718.24767885448, 16728.0, 6660.766873159513, 6758.966205168943, 6773.322667733188, 6845.315468453215, 6870.416014638811, 4133.586641335843, 4175.415441838145, 4181.393697913846, 4193.622573968358, 4267.103908179317, 2780.2354352552807, 2802.0613094613127, 2802.467531169071, 2802.5936239245193, 2804.7055059218897, 525.4535283305396, 550.3148580017823, 556.246286282082, 560.9859753506195, 562.9437056294338, 523.3379774585153, 587.6973358720262, 614.2598169206096, 617.274702224884, 685.8559702462538, 9071.81856362869, 9129.360944733804, 9165.358424910326, 9256.120668536478, 9349.719508414759, 587.700272860844, 625.3933684326196, 643.240975648739, 643.8197304754676, 663.8240866170469, 3950.48643676326, 4086.3053280942313, 4142.233686767958, 4158.2307273154565, 4178.582141785858, 56850.03074677099, 61883.0, 62341.0, 62410.37589624136, 62433.375666243664, 49996.750016250415, 50633.74683126635, 51519.48480515147, 52233.7388313056, 52444.73777631164, 47794.28308575374, 48122.0, 48319.27521087186, 48453.27320090202, 49262.50737492651, 8945.552722363986, 9018.549072546215, 9160.404573702688, 9161.816763664823, 9216.861747073934, 36947.63052369442, 36971.26057478889, 37342.626573735004, 37549.81225093857, 38582.0, 46063.539364605924, 46856.84574696849, 47088.29367559558, 47205.0, 47622.0, 11174.329540227613, 11286.322820630789, 11319.434028298718, 11418.657440276806, 12046.0, 12007.39963001829, 12010.939945300566, 12070.637880863587, 12078.879211207775, 13109.213447193199, 11758.412079395825, 11953.282803031845, 12249.510019599473, 12272.38638068111, 12305.323207223331, 11429.314241145557, 11608.941955290169, 11622.709432263922, 11996.700082498008, 12024.639260822189, 10929.508172132431, 11273.323600583992, 11302.830457543309, 11445.942770286429, 11686.70783230392, 10057.597696092074, 10258.113117776345, 10265.281430300107, 10281.023302786223, 10594.894051059391, 9252.092699768942, 9499.572519236513, 9514.571844267162, 9702.320837541305, 9937.801243975224], "unit": "score", "name": "yui.html", "value": 6303.167827243503}], "name": "dromaeo_css", "value": 6927.798826744626}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 111.0, 110.0, 101.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [144.0, 122.0, 149.0, 161.0, 128.0, 152.0, 151.0, 124.0, 164.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 163.0, 162.0, 162.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 90.0, 71.0, 72.0, 73.0, 127.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 92.0, 94.0, 94.0, 138.0, 93.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 57.0, 58.0, 57.0, 58.0, 59.0, 66.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 83.0, 91.0, 84.0, 85.0, 84.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 123.0, 124.0, 115.0, 122.0, 118.0, 116.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [143.0, 149.0, 156.0, 151.0, 152.0, 143.0, 150.0, 149.0, 155.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1499.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [191.46084625694044], "unit": "score", "name": "DeltaBlue", "value": 345.33431399999995}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1104.9723756906078], "unit": "score", "name": "RayTrace", "value": 669.6900450000003}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [694.4444444444445], "unit": "score", "name": "Splay", "value": 117.34703999999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20757.529773260532}]} 05:18:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20757.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1499.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6927.80"}}} 05:18:38 INFO - Return code: 0 05:18:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:38 ERROR - # TBPL SUCCESS # 05:18:38 INFO - Running post-action listener: _resource_record_post_action 05:18:38 INFO - Running post-run listener: _resource_record_post_run 05:18:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 574025728; Read time: 20; Write time: 738156 05:18:39 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 235204608; Read time: 0; Write time: 403832 05:18:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326959104; Read time: 20; Write time: 314748 05:18:39 INFO - Running post-run listener: _upload_blobber_files 05:18:39 INFO - Blob upload gear active. 05:18:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:18:39 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 05:18:39 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:18:39 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:18:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:40 INFO - (blobuploader) - INFO - Done attempting. 05:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:41 INFO - (blobuploader) - INFO - Done attempting. 05:18:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:41 INFO - Return code: 0 05:18:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:18:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/633e156c75f260bf4e0bf97ee3dad46d031ff2f95701505262866eb9b64f0683756e4a1f860143d070e01dbc03a45d3a6c01d106abda03b9feeda1fc7360e422", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3cd7c754ef5a20dd10b96bb04ebd88bf914f439ff36ae4b688e9911bfea2fb5e9fa71b14a64a65800a4fe7159237c29de0c747be7fa42c28d9c44911ba23da71"} 05:18:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:18:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:18:41 INFO - Contents: 05:18:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/633e156c75f260bf4e0bf97ee3dad46d031ff2f95701505262866eb9b64f0683756e4a1f860143d070e01dbc03a45d3a6c01d106abda03b9feeda1fc7360e422", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3cd7c754ef5a20dd10b96bb04ebd88bf914f439ff36ae4b688e9911bfea2fb5e9fa71b14a64a65800a4fe7159237c29de0c747be7fa42c28d9c44911ba23da71"} 05:18:41 INFO - Copying logs to upload dir... 05:18:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.107835 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-24 05:18:41.362530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 05:18:41.365917) ========= 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/633e156c75f260bf4e0bf97ee3dad46d031ff2f95701505262866eb9b64f0683756e4a1f860143d070e01dbc03a45d3a6c01d106abda03b9feeda1fc7360e422", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3cd7c754ef5a20dd10b96bb04ebd88bf914f439ff36ae4b688e9911bfea2fb5e9fa71b14a64a65800a4fe7159237c29de0c747be7fa42c28d9c44911ba23da71"} build_url:https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011502 build_url: 'https://queue.taskcluster.net/v1/task/FYsTNeHzQvCvp1wulRzr0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/633e156c75f260bf4e0bf97ee3dad46d031ff2f95701505262866eb9b64f0683756e4a1f860143d070e01dbc03a45d3a6c01d106abda03b9feeda1fc7360e422", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/3cd7c754ef5a20dd10b96bb04ebd88bf914f439ff36ae4b688e9911bfea2fb5e9fa71b14a64a65800a4fe7159237c29de0c747be7fa42c28d9c44911ba23da71"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 05:18:41.391288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:18:41.391674) ========= 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=01deea79d00cc2c334834894000001d2-1450958285.902599-1055913465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 05:18:41.474540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 05:18:41.474950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 05:18:41.475375) ========= ========= Total master_lag: 0.28 =========