builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1452087924.56 results: success (0) buildid: 20160106030225 builduid: dbcf7ff382be4f0390432d3162c16352 revision: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.562833) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.563358) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.563680) ========= 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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005791 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.597874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.598427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.648384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.648711) ========= 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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004688 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.697810) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.698143) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.698530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.698809) ========= 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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 05:45:24-- 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% 63.1M=0s 2016-01-06 05:45:24 (63.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.813274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.813626) ========= 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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.868746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:24.869173) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 05:45:24,928 truncating revision to first 12 chars 2016-01-06 05:45:24,928 Setting DEBUG logging. 2016-01-06 05:45:24,929 attempt 1/10 2016-01-06 05:45:24,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9d6ffc7a08b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 05:45:25,200 unpacking tar archive at: mozilla-central-9d6ffc7a08b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:25.427866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:25.428241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:25.438381) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:25.438805) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:45:25.439343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-06 05:45:25.439663) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:25 INFO - MultiFileLogger online at 20160106 05:45:25 in /builds/slave/test-pgo 05:45:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:45:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:45:25 INFO - {'append_to_log': False, 05:45:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:45:25 INFO - 'blob_upload_branch': 'Firefox', 05:45:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:45:25 INFO - 'branch': 'Firefox', 05:45:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:25 INFO - 'config_files': ('talos/linux_config.py',), 05:45:25 INFO - 'default_actions': ('clobber', 05:45:25 INFO - 'read-buildbot-config', 05:45:25 INFO - 'download-and-extract', 05:45:25 INFO - 'populate-webroot', 05:45:25 INFO - 'create-virtualenv', 05:45:25 INFO - 'install', 05:45:25 INFO - 'run-tests'), 05:45:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:25 INFO - 'download_minidump_stackwalk': True, 05:45:25 INFO - 'download_symbols': 'ondemand', 05:45:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:25 INFO - 'installer_path': 'installer.exe', 05:45:25 INFO - 'log_level': 'info', 05:45:25 INFO - 'log_name': 'talos', 05:45:25 INFO - 'log_to_console': True, 05:45:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:25 INFO - 'opt_config_files': (), 05:45:25 INFO - 'pip_index': False, 05:45:25 INFO - 'sps_profile': False, 05:45:25 INFO - 'sps_profile_interval': 0, 05:45:25 INFO - 'suite': 'dromaeojs', 05:45:25 INFO - 'system_bits': '32', 05:45:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:25 INFO - 'title': 'talos-linux64-ix-024', 05:45:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:25 INFO - 'use_talos_json': True, 05:45:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:45:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:25 INFO - 'work_dir': 'build'} 05:45:25 INFO - ##### 05:45:25 INFO - ##### Running clobber step. 05:45:25 INFO - ##### 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: clobber 05:45:25 INFO - rmtree: /builds/slave/test-pgo/build 05:45:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:45:26 INFO - Running post-action listener: _resource_record_post_action 05:45:26 INFO - ##### 05:45:26 INFO - ##### Running read-buildbot-config step. 05:45:26 INFO - ##### 05:45:26 INFO - Running pre-action listener: _resource_record_pre_action 05:45:26 INFO - Running main action method: read_buildbot_config 05:45:26 INFO - Using buildbot properties: 05:45:26 INFO - { 05:45:26 INFO - "project": "", 05:45:26 INFO - "product": "firefox", 05:45:26 INFO - "script_repo_revision": "production", 05:45:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:45:26 INFO - "repository": "", 05:45:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:45:26 INFO - "buildid": "20160106030225", 05:45:26 INFO - "stage_platform": "linux64-pgo", 05:45:26 INFO - "basedir": "/builds/slave/test-pgo", 05:45:26 INFO - "nightly_build": "True", 05:45:26 INFO - "buildnumber": 632, 05:45:26 INFO - "slavename": "talos-linux64-ix-024", 05:45:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:45:26 INFO - "platform": "ubuntu64_hw", 05:45:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:45:26 INFO - "branch": "mozilla-central", 05:45:26 INFO - "repo_path": "mozilla-central", 05:45:26 INFO - "revision": "9d6ffc7a08b6b47056eefe1e652710a3849adbf7", 05:45:26 INFO - "pgo_build": "True", 05:45:26 INFO - "builduid": "dbcf7ff382be4f0390432d3162c16352", 05:45:26 INFO - "slavebuilddir": "test" 05:45:26 INFO - } 05:45:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:45:26 INFO - Running post-action listener: _resource_record_post_action 05:45:26 INFO - ##### 05:45:26 INFO - ##### Running download-and-extract step. 05:45:26 INFO - ##### 05:45:26 INFO - Running pre-action listener: _resource_record_pre_action 05:45:26 INFO - Running main action method: download_and_extract 05:45:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:26 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json 05:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json 05:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:45:26 INFO - Downloaded 1302 bytes. 05:45:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:45:26 INFO - Using the following test package requirements: 05:45:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:45:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'jsshell-linux-x86_64.zip'], 05:45:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:45:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:45:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:45:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:45:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:45:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:45:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:45:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:26 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:28 INFO - Downloaded 24054491 bytes. 05:45:28 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 05:45:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:28 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 05:45:29 INFO - Return code: 0 05:45:29 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 05:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:29 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:31 INFO - Downloaded 24054491 bytes. 05:45:31 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 05:45:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:45:31 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 05:45:32 INFO - Return code: 0 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:32 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:34 INFO - Downloaded 11132285 bytes. 05:45:34 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 05:45:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:45:34 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 05:45:34 INFO - Return code: 0 05:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:34 INFO - https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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 05:45:36 INFO - Downloaded 55064197 bytes. 05:45:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:36 INFO - mkdir: /builds/slave/test-pgo/properties 05:45:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:45:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:45:36 INFO - Contents: 05:45:36 INFO - build_url:https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:45:36 INFO - Running post-action listener: _resource_record_post_action 05:45:36 INFO - Running post-action listener: set_extra_try_arguments 05:45:36 INFO - ##### 05:45:36 INFO - ##### Running populate-webroot step. 05:45:36 INFO - ##### 05:45:36 INFO - Running pre-action listener: _resource_record_pre_action 05:45:36 INFO - Running main action method: populate_webroot 05:45:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:36 INFO - '--tppagecycles', 05:45:36 INFO - '7'], 05:45:36 INFO - 'tests': ['tsvgm']}}, 05:45:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:45:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:45:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'tests': ['damp', 'tps']}, 05:45:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['damp', 'tps']}, 05:45:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:45:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:36 INFO - 'other': {'tests': ['a11yr', 05:45:36 INFO - 'ts_paint', 05:45:36 INFO - 'tpaint', 05:45:36 INFO - 'sessionrestore', 05:45:36 INFO - 'sessionrestore_no_auto_restore']}, 05:45:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['a11yr', 05:45:36 INFO - 'ts_paint', 05:45:36 INFO - 'tpaint', 05:45:36 INFO - 'sessionrestore', 05:45:36 INFO - 'sessionrestore_no_auto_restore']}, 05:45:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['a11yr', 05:45:36 INFO - 'ts_paint', 05:45:36 INFO - 'tpaint', 05:45:36 INFO - 'sessionrestore', 05:45:36 INFO - 'sessionrestore_no_auto_restore']}, 05:45:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['a11yr', 05:45:36 INFO - 'ts_paint', 05:45:36 INFO - 'tpaint', 05:45:36 INFO - 'sessionrestore', 05:45:36 INFO - 'sessionrestore_no_auto_restore']}, 05:45:36 INFO - 'other_l64': {'tests': ['a11yr', 05:45:36 INFO - 'ts_paint', 05:45:36 INFO - 'tpaint', 05:45:36 INFO - 'sessionrestore', 05:45:36 INFO - 'sessionrestore_no_auto_restore']}, 05:45:36 INFO - 'other_nol64': {'tests': ['a11yr', 05:45:36 INFO - 'ts_paint', 05:45:36 INFO - 'tpaint', 05:45:36 INFO - 'sessionrestore', 05:45:36 INFO - 'sessionrestore_no_auto_restore']}, 05:45:36 INFO - 'svgr': {'tests': ['tsvgx', 05:45:36 INFO - 'tsvgr_opacity', 05:45:36 INFO - 'tart', 05:45:36 INFO - 'tscrollx', 05:45:36 INFO - 'cart']}, 05:45:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['tsvgx', 05:45:36 INFO - 'tsvgr_opacity', 05:45:36 INFO - 'tart', 05:45:36 INFO - 'tscrollx', 05:45:36 INFO - 'cart']}, 05:45:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'tests': ['tp5o']}, 05:45:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'talos_options': ['--e10s'], 05:45:36 INFO - 'tests': ['tp5o']}, 05:45:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'talos_options': ['--xperf_path', 05:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:36 INFO - 'tests': ['tp5n']}, 05:45:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:45:36 INFO - 'talos_options': ['--e10s', 05:45:36 INFO - '--xperf_path', 05:45:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:36 INFO - 'tests': ['tp5n']}}, 05:45:36 INFO - 'talos.zip': {'path': '', 05:45:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:36 INFO - Running post-action listener: _resource_record_post_action 05:45:36 INFO - ##### 05:45:36 INFO - ##### Running create-virtualenv step. 05:45:36 INFO - ##### 05:45:36 INFO - Running pre-action listener: _resource_record_pre_action 05:45:36 INFO - Running main action method: create_virtualenv 05:45:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:45:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:45:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:45:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:36 INFO - Using real prefix '/usr' 05:45:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:45:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:39 INFO - Installing pip.................done. 05:45:39 INFO - Return code: 0 05:45:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:39 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:39 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 05:45:39 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 05:45:39 INFO - Using env: {'DISPLAY': ':0', 05:45:39 INFO - 'HOME': '/home/cltbld', 05:45:39 INFO - 'LANG': 'en_US.UTF-8', 05:45:39 INFO - 'LANGUAGE': 'en_US:en', 05:45:39 INFO - 'LOGNAME': 'cltbld', 05:45:39 INFO - 'MAIL': '/var/mail/cltbld', 05:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:39 INFO - 'MOZ_NO_REMOTE': '1', 05:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:39 INFO - 'NO_EM_RESTART': '1', 05:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:39 INFO - 'SHELL': '/bin/bash', 05:45:39 INFO - 'SHLVL': '1', 05:45:39 INFO - 'TERM': 'linux', 05:45:39 INFO - 'TMOUT': '86400', 05:45:39 INFO - 'USER': 'cltbld', 05:45:39 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:39 INFO - '_': '/tools/buildbot/bin/python'} 05:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:39 INFO - Cleaning up... 05:45:39 INFO - Return code: 0 05:45:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:39 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:39 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 05:45:39 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 05:45:39 INFO - Using env: {'DISPLAY': ':0', 05:45:39 INFO - 'HOME': '/home/cltbld', 05:45:39 INFO - 'LANG': 'en_US.UTF-8', 05:45:39 INFO - 'LANGUAGE': 'en_US:en', 05:45:39 INFO - 'LOGNAME': 'cltbld', 05:45:39 INFO - 'MAIL': '/var/mail/cltbld', 05:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:39 INFO - 'MOZ_NO_REMOTE': '1', 05:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:39 INFO - 'NO_EM_RESTART': '1', 05:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:39 INFO - 'SHELL': '/bin/bash', 05:45:39 INFO - 'SHLVL': '1', 05:45:39 INFO - 'TERM': 'linux', 05:45:39 INFO - 'TMOUT': '86400', 05:45:39 INFO - 'USER': 'cltbld', 05:45:39 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:39 INFO - '_': '/tools/buildbot/bin/python'} 05:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:39 INFO - Downloading/unpacking psutil>=0.7.1 05:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:45:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:45:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:41 INFO - Installing collected packages: psutil 05:45:41 INFO - Running setup.py install for psutil 05:45:41 INFO - building 'psutil._psutil_linux' extension 05:45:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:45:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:45:41 INFO - building 'psutil._psutil_posix' extension 05:45:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:45:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:42 INFO - Successfully installed psutil 05:45:42 INFO - Cleaning up... 05:45:42 INFO - Return code: 0 05:45:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:42 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:42 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 05:45:42 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 05:45:42 INFO - Using env: {'DISPLAY': ':0', 05:45:42 INFO - 'HOME': '/home/cltbld', 05:45:42 INFO - 'LANG': 'en_US.UTF-8', 05:45:42 INFO - 'LANGUAGE': 'en_US:en', 05:45:42 INFO - 'LOGNAME': 'cltbld', 05:45:42 INFO - 'MAIL': '/var/mail/cltbld', 05:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:42 INFO - 'MOZ_NO_REMOTE': '1', 05:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:42 INFO - 'NO_EM_RESTART': '1', 05:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:42 INFO - 'SHELL': '/bin/bash', 05:45:42 INFO - 'SHLVL': '1', 05:45:42 INFO - 'TERM': 'linux', 05:45:42 INFO - 'TMOUT': '86400', 05:45:42 INFO - 'USER': 'cltbld', 05:45:42 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:42 INFO - '_': '/tools/buildbot/bin/python'} 05:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:45:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:44 INFO - Installing collected packages: mozsystemmonitor 05:45:44 INFO - Running setup.py install for mozsystemmonitor 05:45:44 INFO - Successfully installed mozsystemmonitor 05:45:44 INFO - Cleaning up... 05:45:44 INFO - Return code: 0 05:45:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:44 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:44 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 05:45:44 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 05:45:44 INFO - Using env: {'DISPLAY': ':0', 05:45:44 INFO - 'HOME': '/home/cltbld', 05:45:44 INFO - 'LANG': 'en_US.UTF-8', 05:45:44 INFO - 'LANGUAGE': 'en_US:en', 05:45:44 INFO - 'LOGNAME': 'cltbld', 05:45:44 INFO - 'MAIL': '/var/mail/cltbld', 05:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:44 INFO - 'MOZ_NO_REMOTE': '1', 05:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:44 INFO - 'NO_EM_RESTART': '1', 05:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:44 INFO - 'SHELL': '/bin/bash', 05:45:44 INFO - 'SHLVL': '1', 05:45:44 INFO - 'TERM': 'linux', 05:45:44 INFO - 'TMOUT': '86400', 05:45:44 INFO - 'USER': 'cltbld', 05:45:44 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:44 INFO - '_': '/tools/buildbot/bin/python'} 05:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:45:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:45:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:47 INFO - Downloading docopt-0.6.1.tar.gz 05:45:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:45:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:47 INFO - Running setup.py install for blobuploader 05:45:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:47 INFO - Running setup.py install for requests 05:45:47 INFO - Running setup.py install for docopt 05:45:47 INFO - Successfully installed blobuploader requests docopt 05:45:47 INFO - Cleaning up... 05:45:47 INFO - Return code: 0 05:45:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:47 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:47 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 05:45:47 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 05:45:47 INFO - Using env: {'DISPLAY': ':0', 05:45:47 INFO - 'HOME': '/home/cltbld', 05:45:47 INFO - 'LANG': 'en_US.UTF-8', 05:45:47 INFO - 'LANGUAGE': 'en_US:en', 05:45:47 INFO - 'LOGNAME': 'cltbld', 05:45:47 INFO - 'MAIL': '/var/mail/cltbld', 05:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:47 INFO - 'MOZ_NO_REMOTE': '1', 05:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:47 INFO - 'NO_EM_RESTART': '1', 05:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:47 INFO - 'SHELL': '/bin/bash', 05:45:47 INFO - 'SHLVL': '1', 05:45:47 INFO - 'TERM': 'linux', 05:45:47 INFO - 'TMOUT': '86400', 05:45:47 INFO - 'USER': 'cltbld', 05:45:47 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:47 INFO - '_': '/tools/buildbot/bin/python'} 05:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:47 INFO - Running setup.py (path:/tmp/pip-DlwoNo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:47 INFO - Running setup.py (path:/tmp/pip-qy3c9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:48 INFO - Running setup.py (path:/tmp/pip-59H_dN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:48 INFO - Running setup.py (path:/tmp/pip-jVr_UT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:48 INFO - Running setup.py (path:/tmp/pip-gjxaub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:48 INFO - Running setup.py (path:/tmp/pip-DhD7bE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:48 INFO - Running setup.py (path:/tmp/pip-ceOcPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:48 INFO - Running setup.py (path:/tmp/pip-KSyMAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:48 INFO - Running setup.py (path:/tmp/pip-Agi4gL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:48 INFO - Running setup.py (path:/tmp/pip-MqO8zk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:48 INFO - Running setup.py (path:/tmp/pip-hBljN0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:48 INFO - Running setup.py (path:/tmp/pip-NmH7J2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:48 INFO - Running setup.py (path:/tmp/pip-ohz91a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:48 INFO - Running setup.py (path:/tmp/pip-T2oPh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:48 INFO - Running setup.py (path:/tmp/pip-OCmaEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:48 INFO - Running setup.py (path:/tmp/pip-rctgcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:49 INFO - Running setup.py (path:/tmp/pip-mIJBzI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:49 INFO - Running setup.py install for manifestparser 05:45:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Running setup.py install for mozcrash 05:45:49 INFO - Running setup.py install for mozdebug 05:45:49 INFO - Running setup.py install for mozdevice 05:45:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Running setup.py install for mozfile 05:45:49 INFO - Running setup.py install for mozhttpd 05:45:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Running setup.py install for mozinfo 05:45:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Running setup.py install for mozInstall 05:45:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:49 INFO - Running setup.py install for mozleak 05:45:50 INFO - Running setup.py install for mozlog 05:45:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Running setup.py install for moznetwork 05:45:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Running setup.py install for mozprocess 05:45:50 INFO - Running setup.py install for mozprofile 05:45:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Running setup.py install for mozrunner 05:45:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Running setup.py install for mozscreenshot 05:45:50 INFO - Running setup.py install for moztest 05:45:50 INFO - Running setup.py install for mozversion 05:45:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:50 INFO - Cleaning up... 05:45:50 INFO - Return code: 0 05:45:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:50 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:50 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 05:45:50 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 05:45:50 INFO - Using env: {'DISPLAY': ':0', 05:45:50 INFO - 'HOME': '/home/cltbld', 05:45:50 INFO - 'LANG': 'en_US.UTF-8', 05:45:50 INFO - 'LANGUAGE': 'en_US:en', 05:45:50 INFO - 'LOGNAME': 'cltbld', 05:45:50 INFO - 'MAIL': '/var/mail/cltbld', 05:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:50 INFO - 'MOZ_NO_REMOTE': '1', 05:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:50 INFO - 'NO_EM_RESTART': '1', 05:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:50 INFO - 'SHELL': '/bin/bash', 05:45:50 INFO - 'SHLVL': '1', 05:45:50 INFO - 'TERM': 'linux', 05:45:50 INFO - 'TMOUT': '86400', 05:45:50 INFO - 'USER': 'cltbld', 05:45:50 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:50 INFO - '_': '/tools/buildbot/bin/python'} 05:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:51 INFO - Running setup.py (path:/tmp/pip-31br0G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:51 INFO - Running setup.py (path:/tmp/pip-b7m_4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:51 INFO - Running setup.py (path:/tmp/pip-TdcS9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:51 INFO - Running setup.py (path:/tmp/pip-Jg6Zrw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:51 INFO - Running setup.py (path:/tmp/pip-36BLpG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:51 INFO - Running setup.py (path:/tmp/pip-QtDPeB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:51 INFO - Running setup.py (path:/tmp/pip-8gVJ4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:51 INFO - Running setup.py (path:/tmp/pip-HGp48b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:51 INFO - Running setup.py (path:/tmp/pip-4ivu5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:51 INFO - Running setup.py (path:/tmp/pip-hNyC3x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:51 INFO - Running setup.py (path:/tmp/pip-af5A7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:45:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:51 INFO - Running setup.py (path:/tmp/pip-Lobd0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:52 INFO - Running setup.py (path:/tmp/pip-RonGrv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:52 INFO - Running setup.py (path:/tmp/pip-enhvRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:52 INFO - Running setup.py (path:/tmp/pip-fkgRVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:52 INFO - Running setup.py (path:/tmp/pip-cb91vW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:52 INFO - Running setup.py (path:/tmp/pip-Ls8TyT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - Downloading blessings-1.5.1.tar.gz 05:45:54 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 05:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:54 INFO - Installing collected packages: blessings 05:45:54 INFO - Running setup.py install for blessings 05:45:54 INFO - Successfully installed blessings 05:45:54 INFO - Cleaning up... 05:45:54 INFO - Return code: 0 05:45:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:54 INFO - Reading from file tmpfile_stdout 05:45:54 INFO - Current package versions: 05:45:54 INFO - argparse == 1.2.1 05:45:54 INFO - blessings == 1.5.1 05:45:54 INFO - blobuploader == 1.2.4 05:45:54 INFO - docopt == 0.6.1 05:45:54 INFO - manifestparser == 1.1 05:45:54 INFO - mozInstall == 1.12 05:45:54 INFO - mozcrash == 0.16 05:45:54 INFO - mozdebug == 0.1 05:45:54 INFO - mozdevice == 0.47 05:45:54 INFO - mozfile == 1.2 05:45:54 INFO - mozhttpd == 0.7 05:45:54 INFO - mozinfo == 0.9 05:45:54 INFO - mozleak == 0.1 05:45:54 INFO - mozlog == 3.1 05:45:54 INFO - moznetwork == 0.27 05:45:54 INFO - mozprocess == 0.22 05:45:54 INFO - mozprofile == 0.28 05:45:54 INFO - mozrunner == 6.11 05:45:54 INFO - mozscreenshot == 0.1 05:45:54 INFO - mozsystemmonitor == 0.0 05:45:54 INFO - moztest == 0.7 05:45:54 INFO - mozversion == 1.4 05:45:54 INFO - psutil == 3.1.1 05:45:54 INFO - requests == 1.2.3 05:45:54 INFO - wsgiref == 0.1.2 05:45:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:54 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 05:45:54 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 05:45:54 INFO - Using env: {'DISPLAY': ':0', 05:45:54 INFO - 'HOME': '/home/cltbld', 05:45:54 INFO - 'LANG': 'en_US.UTF-8', 05:45:54 INFO - 'LANGUAGE': 'en_US:en', 05:45:54 INFO - 'LOGNAME': 'cltbld', 05:45:54 INFO - 'MAIL': '/var/mail/cltbld', 05:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:54 INFO - 'MOZ_NO_REMOTE': '1', 05:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:54 INFO - 'NO_EM_RESTART': '1', 05:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:54 INFO - 'SHELL': '/bin/bash', 05:45:54 INFO - 'SHLVL': '1', 05:45:54 INFO - 'TERM': 'linux', 05:45:54 INFO - 'TMOUT': '86400', 05:45:54 INFO - 'USER': 'cltbld', 05:45:54 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:54 INFO - '_': '/tools/buildbot/bin/python'} 05:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:45:54 INFO - Cleaning up... 05:45:54 INFO - Return code: 0 05:45:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:54 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:54 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 05:45:54 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 05:45:54 INFO - Using env: {'DISPLAY': ':0', 05:45:54 INFO - 'HOME': '/home/cltbld', 05:45:54 INFO - 'LANG': 'en_US.UTF-8', 05:45:54 INFO - 'LANGUAGE': 'en_US:en', 05:45:54 INFO - 'LOGNAME': 'cltbld', 05:45:54 INFO - 'MAIL': '/var/mail/cltbld', 05:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:54 INFO - 'MOZ_NO_REMOTE': '1', 05:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:54 INFO - 'NO_EM_RESTART': '1', 05:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:54 INFO - 'SHELL': '/bin/bash', 05:45:54 INFO - 'SHLVL': '1', 05:45:54 INFO - 'TERM': 'linux', 05:45:54 INFO - 'TMOUT': '86400', 05:45:54 INFO - 'USER': 'cltbld', 05:45:54 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:54 INFO - '_': '/tools/buildbot/bin/python'} 05:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:54 INFO - Downloading/unpacking jsonschema 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:56 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 05:45:56 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:56 INFO - warning: no files found matching '*.txt' 05:45:56 INFO - no previously-included directories found matching 'build' 05:45:56 INFO - no previously-included directories found matching 'dist' 05:45:56 INFO - no previously-included directories found matching '.git*' 05:45:56 INFO - Installing collected packages: jsonschema, functools32 05:45:57 INFO - Running setup.py install for functools32 05:45:57 INFO - warning: no files found matching '*.txt' 05:45:57 INFO - no previously-included directories found matching 'build' 05:45:57 INFO - no previously-included directories found matching 'dist' 05:45:57 INFO - no previously-included directories found matching '.git*' 05:45:57 INFO - Successfully installed jsonschema functools32 05:45:57 INFO - Cleaning up... 05:45:57 INFO - Return code: 0 05:45:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:57 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 0x7f9bbde30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1881630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, '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': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:45:57 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 05:45:57 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 05:45:57 INFO - Using env: {'DISPLAY': ':0', 05:45:57 INFO - 'HOME': '/home/cltbld', 05:45:57 INFO - 'LANG': 'en_US.UTF-8', 05:45:57 INFO - 'LANGUAGE': 'en_US:en', 05:45:57 INFO - 'LOGNAME': 'cltbld', 05:45:57 INFO - 'MAIL': '/var/mail/cltbld', 05:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:57 INFO - 'MOZ_NO_REMOTE': '1', 05:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:57 INFO - 'NO_EM_RESTART': '1', 05:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:57 INFO - 'SHELL': '/bin/bash', 05:45:57 INFO - 'SHLVL': '1', 05:45:57 INFO - 'TERM': 'linux', 05:45:57 INFO - 'TMOUT': '86400', 05:45:57 INFO - 'USER': 'cltbld', 05:45:57 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:57 INFO - '_': '/tools/buildbot/bin/python'} 05:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:57 INFO - Downloading/unpacking flake8 05:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:59 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 05:45:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:59 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 05:45:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 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 05:45:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:59 INFO - no previously-included directories found matching 'docs/_build' 05:45:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:59 INFO - Running setup.py install for pep8 05:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:59 INFO - no previously-included directories found matching 'docs/_build' 05:45:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:45:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:59 INFO - Cleaning up... 05:45:59 INFO - Return code: 0 05:45:59 INFO - Running post-action listener: _resource_record_post_action 05:45:59 INFO - Running post-action listener: _start_resource_monitoring 05:45:59 INFO - Starting resource monitoring. 05:45:59 INFO - ##### 05:45:59 INFO - ##### Running install step. 05:45:59 INFO - ##### 05:45:59 INFO - Running pre-action listener: _resource_record_pre_action 05:45:59 INFO - Running main action method: install 05:45:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:46:00 INFO - Reading from file tmpfile_stdout 05:46:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:46:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:46:00 INFO - Reading from file tmpfile_stdout 05:46:00 INFO - Output received: 05:46:00 INFO - Usage: mozinstall [options] installer 05:46:00 INFO - Options: 05:46:00 INFO - -h, --help show this help message and exit 05:46:00 INFO - -d DEST, --destination=DEST 05:46:00 INFO - Directory to install application into. [default: 05:46:00 INFO - "/builds/slave/test-pgo"] 05:46:00 INFO - --app=APP Application being installed. [default: firefox] 05:46:00 INFO - mkdir: /builds/slave/test-pgo/build/application 05:46:00 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'] 05:46:00 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 05:46:16 INFO - Reading from file tmpfile_stdout 05:46:16 INFO - Output received: 05:46:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:46:16 INFO - Running post-action listener: _resource_record_post_action 05:46:16 INFO - ##### 05:46:16 INFO - ##### Running run-tests step. 05:46:16 INFO - ##### 05:46:16 INFO - Running pre-action listener: _resource_record_pre_action 05:46:16 INFO - Running main action method: run_tests 05:46:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:46:16 INFO - Python 2.7.3 05:46:16 INFO - Return code: 0 05:46:16 INFO - grabbing minidump binary from tooltool 05:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:16 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 0x1912840>, '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 0x187f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x187fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:46:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:46:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:16 INFO - Return code: 0 05:46:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:46:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:46:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:46:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:46:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:46:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:46:17 INFO - Return code: 0 05:46:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:46:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:46:17 INFO - Using env: {'DISPLAY': ':0', 05:46:17 INFO - 'HOME': '/home/cltbld', 05:46:17 INFO - 'LANG': 'en_US.UTF-8', 05:46:17 INFO - 'LANGUAGE': 'en_US:en', 05:46:17 INFO - 'LOGNAME': 'cltbld', 05:46:17 INFO - 'MAIL': '/var/mail/cltbld', 05:46:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:17 INFO - 'MOZ_NO_REMOTE': '1', 05:46:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:17 INFO - 'NO_EM_RESTART': '1', 05:46:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:46:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:46:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:46:17 INFO - 'SHELL': '/bin/bash', 05:46:17 INFO - 'SHLVL': '1', 05:46:17 INFO - 'TERM': 'linux', 05:46:17 INFO - 'TMOUT': '86400', 05:46:17 INFO - 'USER': 'cltbld', 05:46:17 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556', 05:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:17 INFO - '_': '/tools/buildbot/bin/python'} 05:46:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:46:17 INFO - mozversion application_buildid: 20160106030225 05:46:17 INFO - mozversion application_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 05:46:17 INFO - mozversion application_display_name: Nightly 05:46:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:17 INFO - mozversion application_name: Firefox 05:46:17 INFO - mozversion application_remotingname: firefox 05:46:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:17 INFO - mozversion application_vendor: Mozilla 05:46:17 INFO - mozversion application_version: 46.0a1 05:46:17 INFO - mozversion platform_buildid: 20160106030225 05:46:17 INFO - mozversion platform_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 05:46:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:17 INFO - mozversion platform_version: 46.0a1 05:46:17 INFO - using testdate: 1452087977 05:46:17 INFO - actual date: 1452087977 05:46:17 INFO - starting webserver on 'localhost:47012' 05:46:17 INFO - SUITE-START | Running 3 tests 05:46:17 INFO - TEST-START | dromaeo_css 05:46:17 INFO - operating with platform_type : linux_ 05:46:17 INFO - Initialising browser for dromaeo_css test... 05:46:17 INFO - TEST-INFO | started process 13203 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqZ0Y5u/profile http://localhost:47012/getInfo.html) 05:46:21 INFO - PROCESS | 13203 | __metrics Screen width/height:1600/1200 05:46:21 INFO - PROCESS | 13203 | colorDepth:24 05:46:21 INFO - PROCESS | 13203 | Browser inner width/height: 1024/697 05:46:21 INFO - PROCESS | 13203 | __metrics 05:46:21 INFO - PROCESS | 13203 | 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:46:21 INFO - PROCESS | 13203 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:22 INFO - TEST-INFO | 13203: exit 0 05:46:22 INFO - Browser initialized. 05:46:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:22 INFO - TEST-INFO | started process 13297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqZ0Y5u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:34 INFO - PROCESS | 13297 | RSS: Main: 149823488 05:46:34 INFO - PROCESS | 13297 | 05:47:25 INFO - PROCESS | 13297 | 1452088045769 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:49:33 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47012/tests/dromaeo/cssquery-ext.html) 05:49:35 INFO - PROCESS | 13297 | RSS: Main: 313143296 05:49:35 INFO - PROCESS | 13297 | 05:52:37 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-ext.html (next: http://localhost:47012/tests/dromaeo/cssquery-jquery.html) 05:52:38 INFO - PROCESS | 13297 | RSS: Main: 239661056 05:52:38 INFO - PROCESS | 13297 | 05:55:40 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47012/tests/dromaeo/cssquery-mootools.html) 05:55:40 INFO - PROCESS | 13297 | RSS: Main: 236392448 05:55:40 INFO - PROCESS | 13297 | 05:58:42 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47012/tests/dromaeo/cssquery-prototype.html) 05:58:43 INFO - PROCESS | 13297 | RSS: Main: 215789568 05:58:43 INFO - PROCESS | 13297 | 06:01:45 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47012/tests/dromaeo/cssquery-yui.html) 06:01:46 INFO - PROCESS | 13297 | RSS: Main: 220004352 06:01:46 INFO - PROCESS | 13297 | 06:04:48 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-yui.html (next: http://localhost:47012/tests/dromaeo/cssquery-dojo.html) 06:04:49 INFO - PROCESS | 13297 | RSS: Main: 276860928 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | __start_tp_report 06:04:49 INFO - PROCESS | 13297 | _x_x_mozilla_page_load 06:04:49 INFO - PROCESS | 13297 | _x_x_mozilla_page_load_details 06:04:49 INFO - PROCESS | 13297 | |i|pagename|runs| 06:04:49 INFO - PROCESS | 13297 | |0;dojo.html;3114.7663925205607;3161.4309424303615;3203.295275039492;3210.4381733196683;3230.693084157005;4997.300377947081;5113.6931784092885;5160.690358578488;5205.973970130153;5224.84325470236;5090.872728181797;5097.209932460465;5120.564751996085;5177.611679124071;5185.688858668483;4658.324542941272;4711;4713.269443236304;4764.499727528611;4830.73430961297;4734.337192793012;4799.52004799519;4836.87907802306;4845.903081938359;4853.563179313861;4662.114198302345;4759.571638552547;4764.166270902579;4809.446913604946;4815.614750819944;4608.5621865922685;4659.650526210514;4685.969086800898;4688.5545873142;4689.929651055237;4703.365045718819;4729.62163026957;4731.053789242165;4733.644976626732;4741.691790033637;4989.501049895018;4990.800367985276;4996.050750357421;4999.4250661174065;5029.17018691919;5494.642848214853;5566.777328906839;5591.916121258185;5604.131359639263;5699.287589051369;5605.859853503654;5609.0184217762135;5616.241807355996;5617.0731829248125;5618.57860660448;5232.1628539433505;5233.319668443078;5234.659747116425;5237.869053273661;5239.633225674204;5500.7524661390335;5541.390447050821;5610;5677.971610141923;5785.392533783892;5455;5472.425395333512;5477.04151773438;5478.178273258964;5478.342598888159;5519.254900588369;5535.723213839373;5535.8339249821765;5543.1685247213245;5593.468620481048;5364.570834333244;5426.430224826416;5527.336719593594;5565.554755619541;5631.605787594829;5441.918371224435;5480.561555075585;5481.890362192734;5482.095454250004;5484.478974497416;4190.622843944059;4264.381664658669;4278.122984788173;4283.121959998255;4315.223259813201;3788.6590206881515;3869.438931354994;3890.396988466792;3905.3556163233316;3906.5898080701686;5087.8982420351385;5118.334616499831;5118.87202819925;5126.79492820283;5168.870778230575;5464.836054918359;5468.37113731918;5469.753861076261;5473.863153421196;5480.040992826319;5111.97444012785;5116.206987916805;5204.505571970657;5231.398389185217;5232.633715639869;4742.644301677388;4762.857114286577;4763.499832517605;4765.547273009059;4806.975965120222;5723.885522289531;5747.827565172968;5762.423757624288;5813.273340832396;5816.331121920949;5453.7818487260065;5528.115501519737;5563.02647036775;5618.88762224745;5619;5700;5789.450002249948;5790.4209579043445;5790.826275211751;5846.386129456346;5432.320959880015;5454.181872719124;5469.535089517435;5478.91781623284;5483.616146869681;5407.891842163213;5504.9174262385295;5513.200585914939;5516.034693928466;5529.391766905556;5406.621536492407;5416.7562459688625;5456.536194423518;5458.399576046552;5468.972655136698;5404.972975135099;5428;5429.592780541396;5447.754851031634;5452.509274165344;5336.67979921206;5352.063388907003;5360.3299587551555;5449.6730196188355;5458.344998600193;5414.5668346532975;5445.1832225166545;5456.236126942152;5458.563314934875;5460.017196904595;5334.919976200437;5335.73321333924;5337.332833395825;5340.252364668871;5343.866403339792 06:04:49 INFO - PROCESS | 13297 | |1;ext.html;501.09302163084806;510.4359682550779;514.626895500762;537.2907761754483;544.0153322486298;27939.580906286395;28484.572731409018;36163.63836361639;36506.452403213974;36565;38712;39006.414903776466;39385.40921886174;39388.21223575534;39487.60512394875;7394.223606521318;8492.023417307011;8653.134686531328;8662;8663.653453861838;7442.553446793209;10206.693799186;10391.740206494822;10398.064174224319;10399.32404393712;9973.800523989516;10040.548175332091;10052.346597471142;10055.296129270953;10057.497125143751;7570.091589009354;7752.108507521651;10048.799024019516;10150.999999999964;10270.281080324381;9822.508874556315;9929.602815887429;9944.651937182163;9948.204143668561;9950;35810;36083.81958090219;36208.456873146926;36245.275094498225;36263.63736362629;3223.4842425211855;3238.8542515586855;3396.456566949301;3500.912477188065;3852.7880966546827;27697.72302276992;28112.43775124486;28188.85905570459;30576.694233057606;30579.541306880416;3906.1211227473877;3938.684905207605;4018.557958624549;4103.261412945669;4117.238310912491;263955.9999999981;264713;264989;265252;265317;51309.48690513122;51865.48134518682;58941;59149;59410;62800.371996280366;63579.6821015892;64139;64308.35691643024;64444.355556444774;13733.587992360246;14116.85883141176;14349.713005739826;14366.281685915872;14456.349464274133;10162.237832162617;10208.132308753839;10406.895931040744;10415.323004004715;10470.633527826489;18423.355182568546;18561.81438185628;19114;19152.80847191538;19173.712394314098;6869.7595584154315;7015.158181018311;7079.716811327489;7112.715491380287;7149.678264478111;895.70192312471;927.9257659387367;1012.2408193854609;1013.4324778124127;1053.6417618009914;25594.488110238064;26075.411841339817;26443.603345949825;26530.734692652826;26557.468850622878;991.8512223166439;1008.8133695266399;1014;1020.5407566595062;1097.8078836203633;13833.79249311261;14011.719765604834;14056.929715351562;14089.506867259597;14139.080959737585;301069;303695;305514;305568;306050;50733.74633126811;50859.49140508548;50880.74559627252;50897.23654145191;50982.490175098515;1297.7599144158362;1315.0728736240926;1331.5139973909647;1337.6789570503008;1338.631876234024;25854.482910342063;26353.604695929193;26675.599866002412;26725.866370668024;26838.463230735666;42046.36930445985;42485.36271955985;42491.3626295612;42555;42611.36082958696;227703;228286;228721;228851;230482;27349.589756154073;27788.305292367044;30286;31048.223794404417;31503.84248078745;36429;36717;37119.700810471506;37452;37510;31672.524912125875;31720.841395792875;32102.678973210903;34772;34919.65080349266;33343;33992.320153597284;34311.656883431846;34368.65631343755;34475.310493790486;33631.3273734519;33641.327173456884;34085.147871303416;34157.48763768496;34170.14574635654;29161;30110.397792044474;31082.689173107978;31094.22264443407;31166.844165779024;23522.411939701644;23662.526749465258;24077.398065048514;24182.75817241805;24315 06:04:49 INFO - PROCESS | 13297 | |2;jquery.html;351.8926727348158;353.6746193501978;354.11824556853435;355.7936396889804;356.69324381032305;13946.581602551914;14315.069520481187;16049.438269660564;16348.591285217875;17002.91498542507;14420.692689169735;15324.923375383107;15610.921945390257;15627.296771645275;16358;5158.819441319554;5286.920696189561;5295.682259064449;5300.734963251842;5305;3935.232629637222;4006.2588421142036;5099.821506247282;5146.639735218536;5625.353084395286;5734.369219385864;5768.192453056576;5796.536277097843;5797.333306669745;5805.274340707411;5644.379118296984;5667.263255776743;5710.400407957167;5721.141828725725;5722.170285308649;5028.120078986163;5031.9245211321495;5034.01836641855;5034.622403319729;5037.471065538139;19729.605407891762;20317.390478285673;20471.692924606145;20532.794672053238;20899.268525601685;2049.313479984207;2058.3927741316347;2071.2439959414705;2136.6367717488065;2207.3377986603955;13404.061715679907;13408.932955335162;13443.932780336036;13488.595342139752;13819.723605527934;1733.0295034780563;1808.7558179645712;1823.1431227323137;1924.7305377247196;1925.1336898395778;58255.70872145612;61550;62066.37933620651;62576.74232576751;63155.68422157906;10036.397816131055;10042.19662427004;10043.096121349114;10140.797184056277;10254.794904101876;13103.344832758514;13108.606741797761;13117.540886068942;13121.343932803322;13148.539801106916;6901.171859376806;6915.688794004182;7077.82305442368;7113.822154446077;7143.535670181422;6497.220333560003;6505.967470162619;6507.219133703986;6517.608943463312;6555.6066636002;5925.585209035412;5927.110933359944;5947.970260148758;5983.282006159288;6004.309504406961;1667.591440097184;1685.1237356574757;1724.7757791487027;1732.9740053899202;1761.8414342709218;922.2299380017627;927.6243121535789;974.9268804839666;1011.549860312154;1041.8697662792151;14950.925245373703;16206.43277485306;16541.751873721903;16868.578285542713;18103.547411314823;853.4154104438479;873.4453621950107;899.6266549382065;946.3375637053952;984.6799790068256;6910.619915904573;8595.656173753105;8633.352498562634;8720.345974051972;8740.431871928304;371912;377926;387201;391984;392740;68337.31662683409;70662.64668676727;70857;72210.63894680493;72616.63691681508;1134.8978591926766;1138.7608602193466;1146.7247860513583;1170.8302296167008;1195.4560674892903;14746.852531474548;14834.77747833805;15449.2275386228;15624.687506250038;15705.607359816097;23238.1866634667;33757.32485350328;34419.65580344265;34835.47746783851;35164;42541;43392.56607434012;44574.3313850299;44725;44940.325895110946;9193.126652967958;9411.247100231829;9480.905190948002;9520.904790952001;9522.0954009369;12482.438290277141;12540.87459125397;16896.155192240585;16896.40862569804;17018.064006479763;13470.191788492722;13557;13560.728785424433;13815.585532434043;14076.155430674193;13309.534166304133;13459.865401345862;13541.932290338485;13727.176369417866;14056.578302650936;13742.312884355542;13777.448902044207;14061.929690351482;14393.064450810663;14487.20320382389;9203.815923681355;9327.253819694273;9423.952880235554;9432.245420366491;9770.706878793648;10231.897681023094;10268.178545716473;13114.278714670785;14260.928695356457;14803.629909252355 06:04:49 INFO - PROCESS | 13297 | |3;mootools.html;1272.5927703135;1342.6039318401074;1393.5610282760927;1482.8220613526378;1685.4606525911706;6176.073588961653;6743.527953043289;6793.932060679392;6820.386165245127;6827.7951661450115;6696.598204107745;6901.171859376869;6906;6910.689018994145;6975.825604359894;1900.0974537094908;1928.1997970842083;2133.807957283844;2141.0365335598963;2189.025883481851;2157.1694897464513;2158.2446143849684;2165.8917054147228;2166.5775173841107;2170.1102547955343;1858.1081081081022;1867.1691097461635;1877.7371168036486;1878.7181922711566;1880.5110671225511;2108.609907167179;2126.627840127979;2138.379869837745;2151.4836439254545;2155.105631163073;2151.698762173297;2189.9890500547394;2192.0574153114153;2192.736871575405;2193.583219188365;6920.273371295992;6982.79051628452;6983.266756990493;6995.195552511475;7000.5099643025005;4100;4177.937330940038;4197.664186865074;4264.189803937242;4265.360195970598;2772.1267800642936;2802.2293869185933;2823.4776566335295;2823.971760282412;2830.391465834835;954.236610711435;960.2462067277154;1873.653374125791;1882.1436246507942;1917.3864363403716;9145.725628231165;9350.625974961062;9357.064293570656;9377.718668439958;9389.671361502315;3699.2786406650443;3747.269282489888;3747.9250414991548;3775.339315619756;3876.6317199865966;7698.345640620498;7711.768646940601;7727.845443091107;7730.226977302224;7737.0715514138665;4351.36905148758;4353.586409291112;4357;4358.171947329997;4363.06194168249;4081.0817566047403;4110.979445102816;4115.52671442782;4121.793910304473;4123.876283711494;2970.56926745625;3003.0690485949426;3183.570218020584;3253.251752097031;3287.6219234787827;964.0793042644258;1005.5977608956476;1008.7427705935087;1012.7620009297809;1017.954192061359;1042.4943902207424;1043.4626167523732;1086.875009373932;1147.5868687272575;1273.6688461000022;6457.741690332334;6492.64290464029;6504;6513.413792758674;6514.088027676129;1147.2772153543215;1148.5807680196667;1150.0626989004102;1186.1400484648561;1189.601483503019;5230.424653288135;5235.633505654568;5263.3947096083675;5268.236105764643;5269.499397557226;7934.682612695543;8013.879791803128;8060.113387527367;8068.757937261891;8083.636236369378;8073.19268073188;8096.230858068592;8108.270255677017;8124.796880078045;8196.42625016243;6428.325025872309;6465.2564955030775;6593.175853018372;6597.670116494156;6610.96694516534;6537.411632952867;6593.571417857824;6602.471802255904;6607.108040414675;6608.1079054328975;7378.335949764547;7499.5875226863045;7603.581803000667;7611.695532178651;7642.426817988784;7568.8486230276185;7622.885656715264;7656.464047516621;7725.613719313899;7792.649330780242;6372.426481616677;6382.712777925098;6464.547481676237;6477;6501.902471462838;6067.696615169136;6159.353267906805;6420.357964203542;6488.578242414417;6723.596584204964;6153.077038444269;6230.096635987847;6265.310815810166;6327.240731112296;6402.935970640234;6166.630002199882;6178;6230.06549017651;6265;6290.182276304051;6212;6220.098085777628;6236.282827474898;6243.625382477066;6245.96877015612;5782.7686892523825;5815.389384114607;5817.5345972321265;5825.126231065205;5831.183634291117;5791.507721843691;5819.039858423313;5826.096954971986;5827.067669172912;5829.795957141479 06:04:49 INFO - PROCESS | 13297 | |4;prototype.html;331.9551860498832;333.3815771743416;336.81138562405056;336.8433678339572;341.332694582092;5818.127280907861;5836.32882218545;5844.941550584493;5859.589828711992;5879.67661778602;5774.364819869811;5787.942120578793;5793.82618521444;5800.419958004198;5809.7676092956235;4505.842295519666;4508.436445444319;4524.909501809978;4536.092781443708;4538.727676339414;4443.111377724452;4505.707129036618;4514.616257618107;4524.841630542932;4545.52272011439;4461.88845278869;4477.082198149388;4487.887802804923;4493.07891882165;4493.236149854516;4269.978650106761;4486.820527178909;4494.617957473619;4495.595396414338;4502.2571275739465;3851.441540976543;3881.592432794544;3949.9605003949882;3971.463852379921;3973.721839471238;5562.972185139089;5571;5578.163275508666;5585.944140558583;5592.189132575753;4987.127252730757;5099.286099946011;5144.356955380577;5197.038547868657;5199.376074871002;6061.030235162397;6155.292141403751;6171.907421388682;6182.1345011698395;6184.072389141665;4391.824327026915;4394.582514661102;4396.538363471821;4398.252297109499;4407.677696691012;6285.717142728542;6426.325235850262;6431.646259455728;6433.356664333576;6433.356664333576;4538.319252112144;4540;4544.0457503924545;4544.840930567414;4552.817887284537;4603.884902877455;4606.516315786794;4609.746463944515;4610.05493873755;4612.031473390559;5223.112070947948;5224.686518808808;5224.712640804716;5227.876006658586;5229.529342359206;6105.877882442415;6155.230596175478;6222.875542489125;6226.221722284715;6226.688665566703;1616.4180894877834;1632.3062698353153;1635.7219272723428;1637.0750525952799;1637.7870876785942;1069.385103565453;1088.2545456362418;1093.6937657455926;1095.479647167605;1131.3212072756444;5864.03243464832;5868.2664666916635;5874.471297583238;5875.41245875409;5877.882442351129;6377.0434434834215;6381.266154392304;6382.20222472191;6387.169667943138;6388.39310265524;5887.116932460165;5890.49930755882;5891.086881533369;5894.528437724972;5896.528277737856;3381.628020917697;3469.2194256292637;3477.2697733475748;3478.3912815257227;3480.2517458746493;6631.933680663228;6636.30318816527;6692.196936367667;6713.2279787824045;6723.361280678426;6633.170853643294;6634.568753031038;6635.701393437307;6636.104125942936;6639;6177.722002509898;6302.180716506825;6538.1500404947055;6615.206175258903;6631.86736265272;6392.64840433762;6399.104125422537;6405.647689376942;6414.61512309263;6421;6348.77779277723;6349.841253968688;6366.872662546816;6372.36276372359;6377.8952945526935;6461.19235095613;6630.436412904957;6658.966705166443;6691.76578819739;6702.966485167543;4354.760488173054;4373.322135069069;4377.4528183977;4381.430414046281;4382.05785756064;6474.514411419068;6480.25477070143;6484.675766211576;6486.643234621953;6488.870222595616;6078.118672792332;6249;6298.937010630018;6372.58578192416;6378.74485020594;6265.655388953652;6272.874542509216;6277.246730392382;6284.057391391328;6285.717142728497;6170.197874276315;6173.41352571505;6173.567850250619;6178.938210617836;6181.505479561534;6217.906731399123;6306.243250809932;6311.905321420274;6314.936850631619;6314.968425157845;6138.662373569497;6150.661713605616;6152.876942461216;6155.538334624832;6166.475849552839 06:04:49 INFO - PROCESS | 13297 | |5;yui.html;692.1313751242192;726.7746998430487;799.9400044996626;804.8390321935615;869.6564856881528;12584.81122783159;12601;12645.051621128407;12703.809442858364;12810.167339122961;12222.877771222285;12423;12508.124431289812;12515.061370397234;12819.102662813606;666.7233098264214;677.7627830259419;797.9880301795492;807.7859367267679;809.704457872878;785.1089013969157;803.5781214862186;810.3760104719363;810.5501446697081;810.8986376702912;841.7558907916697;852.86780549015;857.669797128107;857.7126662568047;857.8455877941968;683.6035099642221;696.7143471176844;829.1004260377498;850.1625898489982;851.5061264466625;621.6922623301449;621.8911690454153;622.4615707413101;623.0871772852747;623.3268070483912;13484.528041518499;13493.595192144252;13603.387847546885;13615.455381784717;13621.931890340584;11569.553805774278;11832;11939.164258501909;12077.275363478131;12539.561115360919;9443.102905223992;9870.9506452468;9917.851232231522;10281.89718102817;10704.518296676668;3577.749557530974;3600.6579374959338;3602.9279414411567;3675.3568125578186;3703.8518459261595;46575.30137047947;47233.29150062717;47258.81852953669;47417.76291118557;47437.76281118607;9823.950880245553;9835.63996565023;9994.200463962865;10209.183265338756;10314.226433017553;17469.65060698779;17489.125543722763;17514.56213594645;17527.824721752873;17550.561235969202;7194.604296763729;7290.3438690518105;7370.96314518424;7371.373433258126;7455.888161677579;4208.894777630584;4227.3447615619625;4271.594198551133;4312.482502099768;4366.366876802846;2978.3745413462984;2985.626796650419;2985.925351866221;3025.848707564613;3065.708757668018;529.5260741636214;537.9515843574097;538.4991957479582;545.7871430142247;547.7535109200876;596.2040675697905;623.6663385088956;628.7736414890636;660.9655888534525;695.5478938689891;8334.916650833535;8592.269657079094;8620.267277281377;8743.256823170103;8877.201051905231;571.4970825673381;639.2424976402978;646.2568046746186;657.3098246840798;694.6179601219309;4006.1186538961383;4035.1929614077303;4047.817848196838;4092.508898932147;4292.678049146264;50925.745371272904;51656.225156622684;51974.740126299126;52316.73841630767;52340;47994.76002619965;48726;49127.75436122868;49150.26274605884;49427.752861236186;42173.367399489034;43625.34561981573;43688.12623747507;44599.55400445954;44698.77650611726;8010;8239.546824924686;8307.916920830714;8321.791955201168;8438.367122465963;32572.83713581417;33197.66802331946;33341;33521;33649.32701346008;38598.80700596479;39151.608483914795;42607.57392426036;42907.7854610725;43215.35176972411;10121.342112762646;10142;10236;10251.84622230682;10413.375197488174;11134.721631959266;11166.274192177483;11429.942850286028;11668.649940501798;11777.057835373322;10439.269251152651;10757.354558726502;10851.945740271249;10871;10999.835002475129;10231.386116833013;10481.161507079567;10635.574577016832;10678.62624808128;11053.944730276296;10550.788984220426;10865.760937305247;10920.945395272973;10957.780844383227;10982.725431864268;9232.399894006869;9468.810623787347;9536.189423899046;9625.374350667184;9947.651832185838;8062.516249025077;8664;8822.735317940473;9495.14543691071;9535.618575256913 06:04:49 INFO - PROCESS | 13297 | __end_tp_report 06:04:49 INFO - PROCESS | 13297 | __start_cc_report 06:04:49 INFO - PROCESS | 13297 | _x_x_mozilla_cycle_collect,1272 06:04:49 INFO - PROCESS | 13297 | __end_cc_report 06:04:49 INFO - PROCESS | 13297 | __startTimestamp1452089089167__endTimestamp 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | ------- Summary: start ------- 06:04:49 INFO - PROCESS | 13297 | Number of tests: 6 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | [#0] dojo.html Cycles:165 Average:5152.35 Median:5360.33 stddev:555.26 (10.4%) stddev-sans-first:533.46 06:04:49 INFO - PROCESS | 13297 | Values: 3114.8 3161.4 3203.3 3210.4 3230.7 4997.3 5113.7 5160.7 5206.0 5224.8 5090.9 5097.2 5120.6 5177.6 5185.7 4658.3 4711.0 4713.3 4764.5 4830.7 4734.3 4799.5 4836.9 4845.9 4853.6 4662.1 4759.6 4764.2 4809.4 4815.6 4608.6 4659.7 4686.0 4688.6 4689.9 4703.4 4729.6 4731.1 4733.6 4741.7 4989.5 4990.8 4996.1 4999.4 5029.2 5494.6 5566.8 5591.9 5604.1 5699.3 5605.9 5609.0 5616.2 5617.1 5618.6 5232.2 5233.3 5234.7 5237.9 5239.6 5500.8 5541.4 5610.0 5678.0 5785.4 5455.0 5472.4 5477.0 5478.2 5478.3 5519.3 5535.7 5535.8 5543.2 5593.5 5364.6 5426.4 5527.3 5565.6 5631.6 5441.9 5480.6 5481.9 5482.1 5484.5 4190.6 4264.4 4278.1 4283.1 4315.2 3788.7 3869.4 3890.4 3905.4 3906.6 5087.9 5118.3 5118.9 5126.8 5168.9 5464.8 5468.4 5469.8 5473.9 5480.0 5112.0 5116.2 5204.5 5231.4 5232.6 4742.6 4762.9 4763.5 4765.5 4807.0 5723.9 5747.8 5762.4 5813.3 5816.3 5453.8 5528.1 5563.0 5618.9 5619.0 5700.0 5789.5 5790.4 5790.8 5846.4 5432.3 5454.2 5469.5 5478.9 5483.6 5407.9 5504.9 5513.2 5516.0 5529.4 5406.6 5416.8 5456.5 5458.4 5469.0 5405.0 5428.0 5429.6 5447.8 5452.5 5336.7 5352.1 5360.3 5449.7 5458.3 5414.6 5445.2 5456.2 5458.6 5460.0 5334.9 5335.7 5337.3 5340.3 5343.9 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | [#1] ext.html Cycles:180 Average:42966.41 Median:31696.68 stddev:69930.22 (220.6%) stddev-sans-first:70053.70 06:04:49 INFO - PROCESS | 13297 | Values: 501.1 510.4 514.6 537.3 544.0 27939.6 28484.6 36163.6 36506.5 36565.0 38712.0 39006.4 39385.4 39388.2 39487.6 7394.2 8492.0 8653.1 8662.0 8663.7 7442.6 10206.7 10391.7 10398.1 10399.3 9973.8 10040.5 10052.3 10055.3 10057.5 7570.1 7752.1 10048.8 10151.0 10270.3 9822.5 9929.6 9944.7 9948.2 9950.0 35810.0 36083.8 36208.5 36245.3 36263.6 3223.5 3238.9 3396.5 3500.9 3852.8 27697.7 28112.4 28188.9 30576.7 30579.5 3906.1 3938.7 4018.6 4103.3 4117.2 263956.0 264713.0 264989.0 265252.0 265317.0 51309.5 51865.5 58941.0 59149.0 59410.0 62800.4 63579.7 64139.0 64308.4 64444.4 13733.6 14116.9 14349.7 14366.3 14456.3 10162.2 10208.1 10406.9 10415.3 10470.6 18423.4 18561.8 19114.0 19152.8 19173.7 6869.8 7015.2 7079.7 7112.7 7149.7 895.7 927.9 1012.2 1013.4 1053.6 25594.5 26075.4 26443.6 26530.7 26557.5 991.9 1008.8 1014.0 1020.5 1097.8 13833.8 14011.7 14056.9 14089.5 14139.1 301069.0 303695.0 305514.0 305568.0 306050.0 50733.7 50859.5 50880.7 50897.2 50982.5 1297.8 1315.1 1331.5 1337.7 1338.6 25854.5 26353.6 26675.6 26725.9 26838.5 42046.4 42485.4 42491.4 42555.0 42611.4 227703.0 228286.0 228721.0 228851.0 230482.0 27349.6 27788.3 30286.0 31048.2 31503.8 36429.0 36717.0 37119.7 37452.0 37510.0 31672.5 31720.8 32102.7 34772.0 34919.7 33343.0 33992.3 34311.7 34368.7 34475.3 33631.3 33641.3 34085.1 34157.5 34170.1 29161.0 30110.4 31082.7 31094.2 31166.8 23522.4 23662.5 24077.4 24182.8 24315.0 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | [#2] jquery.html Cycles:180 Average:24012.60 Median:17593.69 stddev:63029.22 (358.2%) stddev-sans-first:63180.99 06:04:49 INFO - PROCESS | 13297 | Values: 351.9 353.7 354.1 355.8 356.7 13946.6 14315.1 16049.4 16348.6 17002.9 14420.7 15324.9 15610.9 15627.3 16358.0 5158.8 5286.9 5295.7 5300.7 5305.0 3935.2 4006.3 5099.8 5146.6 5625.4 5734.4 5768.2 5796.5 5797.3 5805.3 5644.4 5667.3 5710.4 5721.1 5722.2 5028.1 5031.9 5034.0 5034.6 5037.5 19729.6 20317.4 20471.7 20532.8 20899.3 2049.3 2058.4 2071.2 2136.6 2207.3 13404.1 13408.9 13443.9 13488.6 13819.7 1733.0 1808.8 1823.1 1924.7 1925.1 58255.7 61550.0 62066.4 62576.7 63155.7 10036.4 10042.2 10043.1 10140.8 10254.8 13103.3 13108.6 13117.5 13121.3 13148.5 6901.2 6915.7 7077.8 7113.8 7143.5 6497.2 6506.0 6507.2 6517.6 6555.6 5925.6 5927.1 5948.0 5983.3 6004.3 1667.6 1685.1 1724.8 1733.0 1761.8 922.2 927.6 974.9 1011.5 1041.9 14950.9 16206.4 16541.8 16868.6 18103.5 853.4 873.4 899.6 946.3 984.7 6910.6 8595.7 8633.4 8720.3 8740.4 371912.0 377926.0 387201.0 391984.0 392740.0 68337.3 70662.6 70857.0 72210.6 72616.6 1134.9 1138.8 1146.7 1170.8 1195.5 14746.9 14834.8 15449.2 15624.7 15705.6 23238.2 33757.3 34419.7 34835.5 35164.0 42541.0 43392.6 44574.3 44725.0 44940.3 9193.1 9411.2 9480.9 9520.9 9522.1 12482.4 12540.9 16896.2 16896.4 17018.1 13470.2 13557.0 13560.7 13815.6 14076.2 13309.5 13459.9 13541.9 13727.2 14056.6 13742.3 13777.4 14061.9 14393.1 14487.2 9203.8 9327.3 9424.0 9432.2 9770.7 10231.9 10268.2 13114.3 14260.9 14803.6 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | [#3] mootools.html Cycles:180 Average:4890.03 Median:5830.49 stddev:2426.97 (41.6%) stddev-sans-first:2418.54 06:04:49 INFO - PROCESS | 13297 | Values: 1272.6 1342.6 1393.6 1482.8 1685.5 6176.1 6743.5 6793.9 6820.4 6827.8 6696.6 6901.2 6906.0 6910.7 6975.8 1900.1 1928.2 2133.8 2141.0 2189.0 2157.2 2158.2 2165.9 2166.6 2170.1 1858.1 1867.2 1877.7 1878.7 1880.5 2108.6 2126.6 2138.4 2151.5 2155.1 2151.7 2190.0 2192.1 2192.7 2193.6 6920.3 6982.8 6983.3 6995.2 7000.5 4100.0 4177.9 4197.7 4264.2 4265.4 2772.1 2802.2 2823.5 2824.0 2830.4 954.2 960.2 1873.7 1882.1 1917.4 9145.7 9350.6 9357.1 9377.7 9389.7 3699.3 3747.3 3747.9 3775.3 3876.6 7698.3 7711.8 7727.8 7730.2 7737.1 4351.4 4353.6 4357.0 4358.2 4363.1 4081.1 4111.0 4115.5 4121.8 4123.9 2970.6 3003.1 3183.6 3253.3 3287.6 964.1 1005.6 1008.7 1012.8 1018.0 1042.5 1043.5 1086.9 1147.6 1273.7 6457.7 6492.6 6504.0 6513.4 6514.1 1147.3 1148.6 1150.1 1186.1 1189.6 5230.4 5235.6 5263.4 5268.2 5269.5 7934.7 8013.9 8060.1 8068.8 8083.6 8073.2 8096.2 8108.3 8124.8 8196.4 6428.3 6465.3 6593.2 6597.7 6611.0 6537.4 6593.6 6602.5 6607.1 6608.1 7378.3 7499.6 7603.6 7611.7 7642.4 7568.8 7622.9 7656.5 7725.6 7792.6 6372.4 6382.7 6464.5 6477.0 6501.9 6067.7 6159.4 6420.4 6488.6 6723.6 6153.1 6230.1 6265.3 6327.2 6402.9 6166.6 6178.0 6230.1 6265.0 6290.2 6212.0 6220.1 6236.3 6243.6 6246.0 5782.8 5815.4 5817.5 5825.1 5831.2 5791.5 5819.0 5826.1 5827.1 5829.8 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | [#4] prototype.html Cycles:180 Average:5211.52 Median:5871.37 stddev:1553.18 (26.5%) stddev-sans-first:1513.74 06:04:49 INFO - PROCESS | 13297 | Values: 332.0 333.4 336.8 336.8 341.3 5818.1 5836.3 5844.9 5859.6 5879.7 5774.4 5787.9 5793.8 5800.4 5809.8 4505.8 4508.4 4524.9 4536.1 4538.7 4443.1 4505.7 4514.6 4524.8 4545.5 4461.9 4477.1 4487.9 4493.1 4493.2 4270.0 4486.8 4494.6 4495.6 4502.3 3851.4 3881.6 3950.0 3971.5 3973.7 5563.0 5571.0 5578.2 5585.9 5592.2 4987.1 5099.3 5144.4 5197.0 5199.4 6061.0 6155.3 6171.9 6182.1 6184.1 4391.8 4394.6 4396.5 4398.3 4407.7 6285.7 6426.3 6431.6 6433.4 6433.4 4538.3 4540.0 4544.0 4544.8 4552.8 4603.9 4606.5 4609.7 4610.1 4612.0 5223.1 5224.7 5224.7 5227.9 5229.5 6105.9 6155.2 6222.9 6226.2 6226.7 1616.4 1632.3 1635.7 1637.1 1637.8 1069.4 1088.3 1093.7 1095.5 1131.3 5864.0 5868.3 5874.5 5875.4 5877.9 6377.0 6381.3 6382.2 6387.2 6388.4 5887.1 5890.5 5891.1 5894.5 5896.5 3381.6 3469.2 3477.3 3478.4 3480.3 6631.9 6636.3 6692.2 6713.2 6723.4 6633.2 6634.6 6635.7 6636.1 6639.0 6177.7 6302.2 6538.2 6615.2 6631.9 6392.6 6399.1 6405.6 6414.6 6421.0 6348.8 6349.8 6366.9 6372.4 6377.9 6461.2 6630.4 6659.0 6691.8 6703.0 4354.8 4373.3 4377.5 4381.4 4382.1 6474.5 6480.3 6484.7 6486.6 6488.9 6078.1 6249.0 6298.9 6372.6 6378.7 6265.7 6272.9 6277.2 6284.1 6285.7 6170.2 6173.4 6173.6 6178.9 6181.5 6217.9 6306.2 6311.9 6314.9 6315.0 6138.7 6150.7 6152.9 6155.5 6166.5 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - PROCESS | 13297 | [#5] yui.html Cycles:180 Average:13127.71 Median:47246.06 stddev:14945.77 (31.6%) stddev-sans-first:14958.52 06:04:49 INFO - PROCESS | 13297 | Values: 692.1 726.8 799.9 804.8 869.7 12584.8 12601.0 12645.1 12703.8 12810.2 12222.9 12423.0 12508.1 12515.1 12819.1 666.7 677.8 798.0 807.8 809.7 785.1 803.6 810.4 810.6 810.9 841.8 852.9 857.7 857.7 857.8 683.6 696.7 829.1 850.2 851.5 621.7 621.9 622.5 623.1 623.3 13484.5 13493.6 13603.4 13615.5 13621.9 11569.6 11832.0 11939.2 12077.3 12539.6 9443.1 9871.0 9917.9 10281.9 10704.5 3577.7 3600.7 3602.9 3675.4 3703.9 46575.3 47233.3 47258.8 47417.8 47437.8 9824.0 9835.6 9994.2 10209.2 10314.2 17469.7 17489.1 17514.6 17527.8 17550.6 7194.6 7290.3 7371.0 7371.4 7455.9 4208.9 4227.3 4271.6 4312.5 4366.4 2978.4 2985.6 2985.9 3025.8 3065.7 529.5 538.0 538.5 545.8 547.8 596.2 623.7 628.8 661.0 695.5 8334.9 8592.3 8620.3 8743.3 8877.2 571.5 639.2 646.3 657.3 694.6 4006.1 4035.2 4047.8 4092.5 4292.7 50925.7 51656.2 51974.7 52316.7 52340.0 47994.8 48726.0 49127.8 49150.3 49427.8 42173.4 43625.3 43688.1 44599.6 44698.8 8010.0 8239.5 8307.9 8321.8 8438.4 32572.8 33197.7 33341.0 33521.0 33649.3 38598.8 39151.6 42607.6 42907.8 43215.4 10121.3 10142.0 10236.0 10251.8 10413.4 11134.7 11166.3 11429.9 11668.6 11777.1 10439.3 10757.4 10851.9 10871.0 10999.8 10231.4 10481.2 10635.6 10678.6 11053.9 10550.8 10865.8 10920.9 10957.8 10982.7 9232.4 9468.8 9536.2 9625.4 9947.7 8062.5 8664.0 8822.7 9495.1 9535.6 06:04:49 INFO - PROCESS | 13297 | -------- Summary: end -------- 06:04:49 INFO - PROCESS | 13297 | 06:04:49 INFO - TEST-INFO | 13297: exit 0 06:04:49 INFO - TEST-OK | dromaeo_css | took 1112490ms 06:04:49 INFO - TEST-START | kraken 06:04:49 INFO - operating with platform_type : linux_ 06:04:49 INFO - Initialising browser for kraken test... 06:04:49 INFO - TEST-INFO | started process 13486 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4ekHfG/profile http://localhost:47012/getInfo.html) 06:04:53 INFO - PROCESS | 13486 | __metrics Screen width/height:1600/1200 06:04:53 INFO - PROCESS | 13486 | colorDepth:24 06:04:53 INFO - PROCESS | 13486 | Browser inner width/height: 1024/697 06:04:53 INFO - PROCESS | 13486 | __metrics 06:04:53 INFO - PROCESS | 13486 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:04:53 INFO - PROCESS | 13486 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:04:54 INFO - TEST-INFO | 13486: exit 0 06:04:54 INFO - Browser initialized. 06:04:54 INFO - Running cycle 1/1 for kraken test... 06:04:54 INFO - TEST-INFO | started process 13571 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4ekHfG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:06 INFO - PROCESS | 13571 | RSS: Main: 150036480 06:05:06 INFO - PROCESS | 13571 | 06:05:08 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:09 INFO - PROCESS | 13571 | RSS: Main: 184406016 06:05:09 INFO - PROCESS | 13571 | 06:05:11 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-dft) 06:05:12 INFO - PROCESS | 13571 | RSS: Main: 175407104 06:05:12 INFO - PROCESS | 13571 | 06:05:15 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-fft) 06:05:15 INFO - PROCESS | 13571 | RSS: Main: 160169984 06:05:15 INFO - PROCESS | 13571 | 06:05:17 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-oscillator) 06:05:18 INFO - PROCESS | 13571 | RSS: Main: 162152448 06:05:18 INFO - PROCESS | 13571 | 06:05:20 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:21 INFO - PROCESS | 13571 | RSS: Main: 163061760 06:05:21 INFO - PROCESS | 13571 | 06:05:24 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47012/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:24 INFO - PROCESS | 13571 | RSS: Main: 165355520 06:05:24 INFO - PROCESS | 13571 | 06:05:28 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47012/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:28 INFO - PROCESS | 13571 | RSS: Main: 165912576 06:05:28 INFO - PROCESS | 13571 | 06:05:31 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47012/tests/kraken/driver.html?testName=json-parse-financial) 06:05:32 INFO - PROCESS | 13571 | RSS: Main: 164274176 06:05:32 INFO - PROCESS | 13571 | 06:05:33 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:34 INFO - PROCESS | 13571 | RSS: Main: 174166016 06:05:34 INFO - PROCESS | 13571 | 06:05:35 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:36 INFO - PROCESS | 13571 | RSS: Main: 173260800 06:05:36 INFO - PROCESS | 13571 | 06:05:38 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:39 INFO - PROCESS | 13571 | RSS: Main: 178659328 06:05:39 INFO - PROCESS | 13571 | 06:05:41 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:42 INFO - PROCESS | 13571 | RSS: Main: 188092416 06:05:42 INFO - PROCESS | 13571 | 06:05:44 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:45 INFO - PROCESS | 13571 | RSS: Main: 186802176 06:05:45 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47012/tests/kraken/driver.html?testName=ai-astar) 06:05:47 INFO - PROCESS | 13571 | RSS: Main: 245919744 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | __start_tp_report 06:05:47 INFO - PROCESS | 13571 | _x_x_mozilla_page_load 06:05:47 INFO - PROCESS | 13571 | _x_x_mozilla_page_load_details 06:05:47 INFO - PROCESS | 13571 | |i|pagename|runs| 06:05:47 INFO - PROCESS | 13571 | |0;ai-astar;110;111;106;110;112;112;102;111;110;111 06:05:47 INFO - PROCESS | 13571 | |1;audio-beat-detection;155;133;151;162;126;153;160;126;161;125 06:05:47 INFO - PROCESS | 13571 | |2;audio-dft;160;161;158;160;165;160;160;163;160;160 06:05:47 INFO - PROCESS | 13571 | |3;audio-fft;71;75;87;91;71;72;72;106;94;72 06:05:47 INFO - PROCESS | 13571 | |4;audio-oscillator;95;104;148;96;96;96;137;97;97;144 06:05:47 INFO - PROCESS | 13571 | |5;imaging-gaussian-blur;109;110;108;109;109;109;110;109;109;108 06:05:47 INFO - PROCESS | 13571 | |6;imaging-darkroom;145;145;146;145;146;146;147;145;146;146 06:05:47 INFO - PROCESS | 13571 | |7;imaging-desaturate;95;96;96;95;96;95;96;97;96;96 06:05:47 INFO - PROCESS | 13571 | |8;json-parse-financial;60;60;59;59;59;60;60;68;56;57 06:05:47 INFO - PROCESS | 13571 | |9;json-stringify-tinderbox;69;68;68;68;69;68;68;68;68;68 06:05:47 INFO - PROCESS | 13571 | |10;stanford-crypto-aes;86;88;94;85;87;87;86;86;85;85 06:05:47 INFO - PROCESS | 13571 | |11;stanford-crypto-ccm;116;116;119;117;117;120;116;117;119;118 06:05:47 INFO - PROCESS | 13571 | |12;stanford-crypto-pbkdf2;146;145;157;168;159;146;156;159;154;145 06:05:47 INFO - PROCESS | 13571 | |13;stanford-crypto-sha256-iterative;74;70;75;74;72;70;71;72;71;69 06:05:47 INFO - PROCESS | 13571 | __end_tp_report 06:05:47 INFO - PROCESS | 13571 | __start_cc_report 06:05:47 INFO - PROCESS | 13571 | _x_x_mozilla_cycle_collect,952 06:05:47 INFO - PROCESS | 13571 | __end_cc_report 06:05:47 INFO - PROCESS | 13571 | __startTimestamp1452089147374__endTimestamp 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | ------- Summary: start ------- 06:05:47 INFO - PROCESS | 13571 | Number of tests: 14 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:3.32 06:05:47 INFO - PROCESS | 13571 | Values: 110.0 111.0 106.0 110.0 112.0 112.0 102.0 111.0 110.0 111.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:154.00 stddev:15.76 (10.2%) stddev-sans-first:16.31 06:05:47 INFO - PROCESS | 13571 | Values: 155.0 133.0 151.0 162.0 126.0 153.0 160.0 126.0 161.0 125.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.00 stddev:1.95 (1.2%) stddev-sans-first:2.05 06:05:47 INFO - PROCESS | 13571 | Values: 160.0 161.0 158.0 160.0 165.0 160.0 160.0 163.0 160.0 160.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#3] audio-fft Cycles:10 Average:81.10 Median:73.50 stddev:12.51 (17.0%) stddev-sans-first:12.73 06:05:47 INFO - PROCESS | 13571 | Values: 71.0 75.0 87.0 91.0 71.0 72.0 72.0 106.0 94.0 72.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:96.00 stddev:22.38 (23.3%) stddev-sans-first:22.97 06:05:47 INFO - PROCESS | 13571 | Values: 95.0 104.0 148.0 96.0 96.0 96.0 137.0 97.0 97.0 144.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:05:47 INFO - PROCESS | 13571 | Values: 109.0 110.0 108.0 109.0 109.0 109.0 110.0 109.0 109.0 108.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 06:05:47 INFO - PROCESS | 13571 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 147.0 145.0 146.0 146.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:05:47 INFO - PROCESS | 13571 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 97.0 96.0 96.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:3.19 (5.3%) stddev-sans-first:3.38 06:05:47 INFO - PROCESS | 13571 | Values: 60.0 60.0 59.0 59.0 59.0 60.0 60.0 68.0 56.0 57.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 06:05:47 INFO - PROCESS | 13571 | Values: 69.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:2.69 (3.1%) stddev-sans-first:2.83 06:05:47 INFO - PROCESS | 13571 | Values: 86.0 88.0 94.0 85.0 87.0 87.0 86.0 86.0 85.0 85.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:117.50 stddev:1.43 (1.2%) stddev-sans-first:1.41 06:05:47 INFO - PROCESS | 13571 | Values: 116.0 116.0 119.0 117.0 117.0 120.0 116.0 117.0 119.0 118.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:156.50 stddev:7.79 (5.0%) stddev-sans-first:7.78 06:05:47 INFO - PROCESS | 13571 | Values: 146.0 145.0 157.0 168.0 159.0 146.0 156.0 159.0 154.0 145.0 06:05:47 INFO - PROCESS | 13571 | 06:05:47 INFO - PROCESS | 13571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.99 (2.8%) stddev-sans-first:1.94 06:05:47 INFO - PROCESS | 13571 | Values: 74.0 70.0 75.0 74.0 72.0 70.0 71.0 72.0 71.0 69.0 06:05:47 INFO - PROCESS | 13571 | -------- Summary: end -------- 06:05:47 INFO - PROCESS | 13571 | 06:05:48 INFO - TEST-INFO | 13571: exit 0 06:05:48 INFO - TEST-OK | kraken | took 58460ms 06:05:48 INFO - TEST-START | v8_7 06:05:48 INFO - operating with platform_type : linux_ 06:05:48 INFO - Initialising browser for v8_7 test... 06:05:48 INFO - TEST-INFO | started process 13822 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUect8W/profile http://localhost:47012/getInfo.html) 06:05:51 INFO - PROCESS | 13822 | __metrics Screen width/height:1600/1200 06:05:51 INFO - PROCESS | 13822 | colorDepth:24 06:05:51 INFO - PROCESS | 13822 | Browser inner width/height: 1024/697 06:05:51 INFO - PROCESS | 13822 | __metrics 06:05:51 INFO - PROCESS | 13822 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:05:51 INFO - PROCESS | 13822 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:52 INFO - TEST-INFO | 13822: exit 0 06:05:52 INFO - Browser initialized. 06:05:52 INFO - Running cycle 1/1 for v8_7 test... 06:05:52 INFO - TEST-INFO | started process 13907 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUect8W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:04 INFO - PROCESS | 13907 | RSS: Main: 149872640 06:06:04 INFO - PROCESS | 13907 | 06:06:25 INFO - PROCESS | 13907 | Cycle 1(1): loaded http://localhost:47012/tests/v8_7/run.html (next: http://localhost:47012/tests/v8_7/run.html) 06:06:26 INFO - PROCESS | 13907 | RSS: Main: 536813568 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | __start_tp_report 06:06:26 INFO - PROCESS | 13907 | _x_x_mozilla_page_load 06:06:26 INFO - PROCESS | 13907 | _x_x_mozilla_page_load_details 06:06:26 INFO - PROCESS | 13907 | |i|pagename|runs| 06:06:26 INFO - PROCESS | 13907 | |0;Richards;167.897918065816 06:06:26 INFO - PROCESS | 13907 | |1;DeltaBlue;191.35093761959433 06:06:26 INFO - PROCESS | 13907 | |2;Encrypt;287.35632183908046 06:06:26 INFO - PROCESS | 13907 | |3;Decrypt;5180.412371134021 06:06:26 INFO - PROCESS | 13907 | |4;RayTrace;1112.3470522803113 06:06:26 INFO - PROCESS | 13907 | |5;Earley;791.1392405063291 06:06:26 INFO - PROCESS | 13907 | |6;Boyer;12256.09756097561 06:06:26 INFO - PROCESS | 13907 | |7;RegExp;25794.871794871793 06:06:26 INFO - PROCESS | 13907 | |8;Splay;612.4694376528117 06:06:26 INFO - PROCESS | 13907 | |9;NavierStokes;4830.917874396136 06:06:26 INFO - PROCESS | 13907 | __end_tp_report 06:06:26 INFO - PROCESS | 13907 | __startTimestamp1452089186195__endTimestamp 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | ------- Summary: start ------- 06:06:26 INFO - PROCESS | 13907 | Number of tests: 10 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 167.9 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#1] DeltaBlue Cycles:1 Average:191.35 Median:191.35 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 191.4 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#2] Encrypt Cycles:1 Average:287.36 Median:287.36 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 287.4 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 5180.4 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 1112.3 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 791.1 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 12256.1 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 25794.9 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#8] Splay Cycles:1 Average:612.47 Median:612.47 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 612.5 06:06:26 INFO - PROCESS | 13907 | 06:06:26 INFO - PROCESS | 13907 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:06:26 INFO - PROCESS | 13907 | Values: 4830.9 06:06:26 INFO - PROCESS | 13907 | -------- Summary: end -------- 06:06:26 INFO - PROCESS | 13907 | 06:06:27 INFO - TEST-INFO | 13907: exit 0 06:06:27 INFO - TEST-OK | v8_7 | took 38724ms 06:06:27 INFO - SUITE-END | took 1209s 06:06:27 INFO - Completed test suite (00:20:09) 06:06:27 INFO - Working with test: dromaeo_css 06:06:27 INFO - Generating results file: dromaeo_css 06:06:27 INFO - Working with test: kraken 06:06:27 INFO - Generating results file: kraken 06:06:27 INFO - javascript benchmark 06:06:27 INFO - Working with test: v8_7 06:06:27 INFO - Generating results file: v8_7 06:06:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:06:27 INFO - process_Request line: dromaeo_css 6721.98 graph.html#tests=[[72,1,35]] 06:06:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:27 INFO - process_Request line: kraken 1515.70 graph.html#tests=[[232,1,35]] 06:06:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:06:27 INFO - process_Request line: v8_7 20890.26 graph.html#tests=[[230,1,35]] 06:06:27 INFO - RETURN: dromaeo_css: 6721.98 06:06:27 INFO - RETURN: kraken: 1515.70 06:06:27 INFO - RETURN: v8_7: 20890.26 06:06:27 INFO - javascript benchmark 06:06:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.7663925205607, 3161.4309424303615, 3203.295275039492, 3210.4381733196683, 3230.693084157005, 4997.300377947081, 5113.6931784092885, 5160.690358578488, 5205.973970130153, 5224.84325470236, 5090.872728181797, 5097.209932460465, 5120.564751996085, 5177.611679124071, 5185.688858668483, 4658.324542941272, 4711.0, 4713.269443236304, 4764.499727528611, 4830.73430961297, 4734.337192793012, 4799.52004799519, 4836.87907802306, 4845.903081938359, 4853.563179313861, 4662.114198302345, 4759.571638552547, 4764.166270902579, 4809.446913604946, 4815.614750819944, 4608.5621865922685, 4659.650526210514, 4685.969086800898, 4688.5545873142, 4689.929651055237, 4703.365045718819, 4729.62163026957, 4731.053789242165, 4733.644976626732, 4741.691790033637, 4989.501049895018, 4990.800367985276, 4996.050750357421, 4999.4250661174065, 5029.17018691919, 5494.642848214853, 5566.777328906839, 5591.916121258185, 5604.131359639263, 5699.287589051369, 5605.859853503654, 5609.0184217762135, 5616.241807355996, 5617.0731829248125, 5618.57860660448, 5232.1628539433505, 5233.319668443078, 5234.659747116425, 5237.869053273661, 5239.633225674204, 5500.7524661390335, 5541.390447050821, 5610.0, 5677.971610141923, 5785.392533783892, 5455.0, 5472.425395333512, 5477.04151773438, 5478.178273258964, 5478.342598888159, 5519.254900588369, 5535.723213839373, 5535.8339249821765, 5543.1685247213245, 5593.468620481048, 5364.570834333244, 5426.430224826416, 5527.336719593594, 5565.554755619541, 5631.605787594829, 5441.918371224435, 5480.561555075585, 5481.890362192734, 5482.095454250004, 5484.478974497416, 4190.622843944059, 4264.381664658669, 4278.122984788173, 4283.121959998255, 4315.223259813201, 3788.6590206881515, 3869.438931354994, 3890.396988466792, 3905.3556163233316, 3906.5898080701686, 5087.8982420351385, 5118.334616499831, 5118.87202819925, 5126.79492820283, 5168.870778230575, 5464.836054918359, 5468.37113731918, 5469.753861076261, 5473.863153421196, 5480.040992826319, 5111.97444012785, 5116.206987916805, 5204.505571970657, 5231.398389185217, 5232.633715639869, 4742.644301677388, 4762.857114286577, 4763.499832517605, 4765.547273009059, 4806.975965120222, 5723.885522289531, 5747.827565172968, 5762.423757624288, 5813.273340832396, 5816.331121920949, 5453.7818487260065, 5528.115501519737, 5563.02647036775, 5618.88762224745, 5619.0, 5700.0, 5789.450002249948, 5790.4209579043445, 5790.826275211751, 5846.386129456346, 5432.320959880015, 5454.181872719124, 5469.535089517435, 5478.91781623284, 5483.616146869681, 5407.891842163213, 5504.9174262385295, 5513.200585914939, 5516.034693928466, 5529.391766905556, 5406.621536492407, 5416.7562459688625, 5456.536194423518, 5458.399576046552, 5468.972655136698, 5404.972975135099, 5428.0, 5429.592780541396, 5447.754851031634, 5452.509274165344, 5336.67979921206, 5352.063388907003, 5360.3299587551555, 5449.6730196188355, 5458.344998600193, 5414.5668346532975, 5445.1832225166545, 5456.236126942152, 5458.563314934875, 5460.017196904595, 5334.919976200437, 5335.73321333924, 5337.332833395825, 5340.252364668871, 5343.866403339792], "unit": "score", "name": "dojo.html", "value": 5117.792371177999}, {"lowerIsBetter": false, "replicates": [501.09302163084806, 510.4359682550779, 514.626895500762, 537.2907761754483, 544.0153322486298, 27939.580906286395, 28484.572731409018, 36163.63836361639, 36506.452403213974, 36565.0, 38712.0, 39006.414903776466, 39385.40921886174, 39388.21223575534, 39487.60512394875, 7394.223606521318, 8492.023417307011, 8653.134686531328, 8662.0, 8663.653453861838, 7442.553446793209, 10206.693799186, 10391.740206494822, 10398.064174224319, 10399.32404393712, 9973.800523989516, 10040.548175332091, 10052.346597471142, 10055.296129270953, 10057.497125143751, 7570.091589009354, 7752.108507521651, 10048.799024019516, 10150.999999999964, 10270.281080324381, 9822.508874556315, 9929.602815887429, 9944.651937182163, 9948.204143668561, 9950.0, 35810.0, 36083.81958090219, 36208.456873146926, 36245.275094498225, 36263.63736362629, 3223.4842425211855, 3238.8542515586855, 3396.456566949301, 3500.912477188065, 3852.7880966546827, 27697.72302276992, 28112.43775124486, 28188.85905570459, 30576.694233057606, 30579.541306880416, 3906.1211227473877, 3938.684905207605, 4018.557958624549, 4103.261412945669, 4117.238310912491, 263955.9999999981, 264713.0, 264989.0, 265252.0, 265317.0, 51309.48690513122, 51865.48134518682, 58941.0, 59149.0, 59410.0, 62800.371996280366, 63579.6821015892, 64139.0, 64308.35691643024, 64444.355556444774, 13733.587992360246, 14116.85883141176, 14349.713005739826, 14366.281685915872, 14456.349464274133, 10162.237832162617, 10208.132308753839, 10406.895931040744, 10415.323004004715, 10470.633527826489, 18423.355182568546, 18561.81438185628, 19114.0, 19152.80847191538, 19173.712394314098, 6869.7595584154315, 7015.158181018311, 7079.716811327489, 7112.715491380287, 7149.678264478111, 895.70192312471, 927.9257659387367, 1012.2408193854609, 1013.4324778124127, 1053.6417618009914, 25594.488110238064, 26075.411841339817, 26443.603345949825, 26530.734692652826, 26557.468850622878, 991.8512223166439, 1008.8133695266399, 1014.0, 1020.5407566595062, 1097.8078836203633, 13833.79249311261, 14011.719765604834, 14056.929715351562, 14089.506867259597, 14139.080959737585, 301069.0, 303695.0, 305514.0, 305568.0, 306050.0, 50733.74633126811, 50859.49140508548, 50880.74559627252, 50897.23654145191, 50982.490175098515, 1297.7599144158362, 1315.0728736240926, 1331.5139973909647, 1337.6789570503008, 1338.631876234024, 25854.482910342063, 26353.604695929193, 26675.599866002412, 26725.866370668024, 26838.463230735666, 42046.36930445985, 42485.36271955985, 42491.3626295612, 42555.0, 42611.36082958696, 227703.0, 228286.0, 228721.0, 228851.0, 230482.0, 27349.589756154073, 27788.305292367044, 30286.0, 31048.223794404417, 31503.84248078745, 36429.0, 36717.0, 37119.700810471506, 37452.0, 37510.0, 31672.524912125875, 31720.841395792875, 32102.678973210903, 34772.0, 34919.65080349266, 33343.0, 33992.320153597284, 34311.656883431846, 34368.65631343755, 34475.310493790486, 33631.3273734519, 33641.327173456884, 34085.147871303416, 34157.48763768496, 34170.14574635654, 29161.0, 30110.397792044474, 31082.689173107978, 31094.22264443407, 31166.844165779024, 23522.411939701644, 23662.526749465258, 24077.398065048514, 24182.75817241805, 24315.0], "unit": "score", "name": "ext.html", "value": 17682.97645184241}, {"lowerIsBetter": false, "replicates": [351.8926727348158, 353.6746193501978, 354.11824556853435, 355.7936396889804, 356.69324381032305, 13946.581602551914, 14315.069520481187, 16049.438269660564, 16348.591285217875, 17002.91498542507, 14420.692689169735, 15324.923375383107, 15610.921945390257, 15627.296771645275, 16358.0, 5158.819441319554, 5286.920696189561, 5295.682259064449, 5300.734963251842, 5305.0, 3935.232629637222, 4006.2588421142036, 5099.821506247282, 5146.639735218536, 5625.353084395286, 5734.369219385864, 5768.192453056576, 5796.536277097843, 5797.333306669745, 5805.274340707411, 5644.379118296984, 5667.263255776743, 5710.400407957167, 5721.141828725725, 5722.170285308649, 5028.120078986163, 5031.9245211321495, 5034.01836641855, 5034.622403319729, 5037.471065538139, 19729.605407891762, 20317.390478285673, 20471.692924606145, 20532.794672053238, 20899.268525601685, 2049.313479984207, 2058.3927741316347, 2071.2439959414705, 2136.6367717488065, 2207.3377986603955, 13404.061715679907, 13408.932955335162, 13443.932780336036, 13488.595342139752, 13819.723605527934, 1733.0295034780563, 1808.7558179645712, 1823.1431227323137, 1924.7305377247196, 1925.1336898395778, 58255.70872145612, 61550.0, 62066.37933620651, 62576.74232576751, 63155.68422157906, 10036.397816131055, 10042.19662427004, 10043.096121349114, 10140.797184056277, 10254.794904101876, 13103.344832758514, 13108.606741797761, 13117.540886068942, 13121.343932803322, 13148.539801106916, 6901.171859376806, 6915.688794004182, 7077.82305442368, 7113.822154446077, 7143.535670181422, 6497.220333560003, 6505.967470162619, 6507.219133703986, 6517.608943463312, 6555.6066636002, 5925.585209035412, 5927.110933359944, 5947.970260148758, 5983.282006159288, 6004.309504406961, 1667.591440097184, 1685.1237356574757, 1724.7757791487027, 1732.9740053899202, 1761.8414342709218, 922.2299380017627, 927.6243121535789, 974.9268804839666, 1011.549860312154, 1041.8697662792151, 14950.925245373703, 16206.43277485306, 16541.751873721903, 16868.578285542713, 18103.547411314823, 853.4154104438479, 873.4453621950107, 899.6266549382065, 946.3375637053952, 984.6799790068256, 6910.619915904573, 8595.656173753105, 8633.352498562634, 8720.345974051972, 8740.431871928304, 371912.0, 377926.0, 387201.0, 391984.0, 392740.0, 68337.31662683409, 70662.64668676727, 70857.0, 72210.63894680493, 72616.63691681508, 1134.8978591926766, 1138.7608602193466, 1146.7247860513583, 1170.8302296167008, 1195.4560674892903, 14746.852531474548, 14834.77747833805, 15449.2275386228, 15624.687506250038, 15705.607359816097, 23238.1866634667, 33757.32485350328, 34419.65580344265, 34835.47746783851, 35164.0, 42541.0, 43392.56607434012, 44574.3313850299, 44725.0, 44940.325895110946, 9193.126652967958, 9411.247100231829, 9480.905190948002, 9520.904790952001, 9522.0954009369, 12482.438290277141, 12540.87459125397, 16896.155192240585, 16896.40862569804, 17018.064006479763, 13470.191788492722, 13557.0, 13560.728785424433, 13815.585532434043, 14076.155430674193, 13309.534166304133, 13459.865401345862, 13541.932290338485, 13727.176369417866, 14056.578302650936, 13742.312884355542, 13777.448902044207, 14061.929690351482, 14393.064450810663, 14487.20320382389, 9203.815923681355, 9327.253819694273, 9423.952880235554, 9432.245420366491, 9770.706878793648, 10231.897681023094, 10268.178545716473, 13114.278714670785, 14260.928695356457, 14803.629909252355], "unit": "score", "name": "jquery.html", "value": 8650.247205417823}, {"lowerIsBetter": false, "replicates": [1272.5927703135, 1342.6039318401074, 1393.5610282760927, 1482.8220613526378, 1685.4606525911706, 6176.073588961653, 6743.527953043289, 6793.932060679392, 6820.386165245127, 6827.7951661450115, 6696.598204107745, 6901.171859376869, 6906.0, 6910.689018994145, 6975.825604359894, 1900.0974537094908, 1928.1997970842083, 2133.807957283844, 2141.0365335598963, 2189.025883481851, 2157.1694897464513, 2158.2446143849684, 2165.8917054147228, 2166.5775173841107, 2170.1102547955343, 1858.1081081081022, 1867.1691097461635, 1877.7371168036486, 1878.7181922711566, 1880.5110671225511, 2108.609907167179, 2126.627840127979, 2138.379869837745, 2151.4836439254545, 2155.105631163073, 2151.698762173297, 2189.9890500547394, 2192.0574153114153, 2192.736871575405, 2193.583219188365, 6920.273371295992, 6982.79051628452, 6983.266756990493, 6995.195552511475, 7000.5099643025005, 4100.0, 4177.937330940038, 4197.664186865074, 4264.189803937242, 4265.360195970598, 2772.1267800642936, 2802.2293869185933, 2823.4776566335295, 2823.971760282412, 2830.391465834835, 954.236610711435, 960.2462067277154, 1873.653374125791, 1882.1436246507942, 1917.3864363403716, 9145.725628231165, 9350.625974961062, 9357.064293570656, 9377.718668439958, 9389.671361502315, 3699.2786406650443, 3747.269282489888, 3747.9250414991548, 3775.339315619756, 3876.6317199865966, 7698.345640620498, 7711.768646940601, 7727.845443091107, 7730.226977302224, 7737.0715514138665, 4351.36905148758, 4353.586409291112, 4357.0, 4358.171947329997, 4363.06194168249, 4081.0817566047403, 4110.979445102816, 4115.52671442782, 4121.793910304473, 4123.876283711494, 2970.56926745625, 3003.0690485949426, 3183.570218020584, 3253.251752097031, 3287.6219234787827, 964.0793042644258, 1005.5977608956476, 1008.7427705935087, 1012.7620009297809, 1017.954192061359, 1042.4943902207424, 1043.4626167523732, 1086.875009373932, 1147.5868687272575, 1273.6688461000022, 6457.741690332334, 6492.64290464029, 6504.0, 6513.413792758674, 6514.088027676129, 1147.2772153543215, 1148.5807680196667, 1150.0626989004102, 1186.1400484648561, 1189.601483503019, 5230.424653288135, 5235.633505654568, 5263.3947096083675, 5268.236105764643, 5269.499397557226, 7934.682612695543, 8013.879791803128, 8060.113387527367, 8068.757937261891, 8083.636236369378, 8073.19268073188, 8096.230858068592, 8108.270255677017, 8124.796880078045, 8196.42625016243, 6428.325025872309, 6465.2564955030775, 6593.175853018372, 6597.670116494156, 6610.96694516534, 6537.411632952867, 6593.571417857824, 6602.471802255904, 6607.108040414675, 6608.1079054328975, 7378.335949764547, 7499.5875226863045, 7603.581803000667, 7611.695532178651, 7642.426817988784, 7568.8486230276185, 7622.885656715264, 7656.464047516621, 7725.613719313899, 7792.649330780242, 6372.426481616677, 6382.712777925098, 6464.547481676237, 6477.0, 6501.902471462838, 6067.696615169136, 6159.353267906805, 6420.357964203542, 6488.578242414417, 6723.596584204964, 6153.077038444269, 6230.096635987847, 6265.310815810166, 6327.240731112296, 6402.935970640234, 6166.630002199882, 6178.0, 6230.06549017651, 6265.0, 6290.182276304051, 6212.0, 6220.098085777628, 6236.282827474898, 6243.625382477066, 6245.96877015612, 5782.7686892523825, 5815.389384114607, 5817.5345972321265, 5825.126231065205, 5831.183634291117, 5791.507721843691, 5819.039858423313, 5826.096954971986, 5827.067669172912, 5829.795957141479], "unit": "score", "name": "mootools.html", "value": 4105.014703248361}, {"lowerIsBetter": false, "replicates": [331.9551860498832, 333.3815771743416, 336.81138562405056, 336.8433678339572, 341.332694582092, 5818.127280907861, 5836.32882218545, 5844.941550584493, 5859.589828711992, 5879.67661778602, 5774.364819869811, 5787.942120578793, 5793.82618521444, 5800.419958004198, 5809.7676092956235, 4505.842295519666, 4508.436445444319, 4524.909501809978, 4536.092781443708, 4538.727676339414, 4443.111377724452, 4505.707129036618, 4514.616257618107, 4524.841630542932, 4545.52272011439, 4461.88845278869, 4477.082198149388, 4487.887802804923, 4493.07891882165, 4493.236149854516, 4269.978650106761, 4486.820527178909, 4494.617957473619, 4495.595396414338, 4502.2571275739465, 3851.441540976543, 3881.592432794544, 3949.9605003949882, 3971.463852379921, 3973.721839471238, 5562.972185139089, 5571.0, 5578.163275508666, 5585.944140558583, 5592.189132575753, 4987.127252730757, 5099.286099946011, 5144.356955380577, 5197.038547868657, 5199.376074871002, 6061.030235162397, 6155.292141403751, 6171.907421388682, 6182.1345011698395, 6184.072389141665, 4391.824327026915, 4394.582514661102, 4396.538363471821, 4398.252297109499, 4407.677696691012, 6285.717142728542, 6426.325235850262, 6431.646259455728, 6433.356664333576, 6433.356664333576, 4538.319252112144, 4540.0, 4544.0457503924545, 4544.840930567414, 4552.817887284537, 4603.884902877455, 4606.516315786794, 4609.746463944515, 4610.05493873755, 4612.031473390559, 5223.112070947948, 5224.686518808808, 5224.712640804716, 5227.876006658586, 5229.529342359206, 6105.877882442415, 6155.230596175478, 6222.875542489125, 6226.221722284715, 6226.688665566703, 1616.4180894877834, 1632.3062698353153, 1635.7219272723428, 1637.0750525952799, 1637.7870876785942, 1069.385103565453, 1088.2545456362418, 1093.6937657455926, 1095.479647167605, 1131.3212072756444, 5864.03243464832, 5868.2664666916635, 5874.471297583238, 5875.41245875409, 5877.882442351129, 6377.0434434834215, 6381.266154392304, 6382.20222472191, 6387.169667943138, 6388.39310265524, 5887.116932460165, 5890.49930755882, 5891.086881533369, 5894.528437724972, 5896.528277737856, 3381.628020917697, 3469.2194256292637, 3477.2697733475748, 3478.3912815257227, 3480.2517458746493, 6631.933680663228, 6636.30318816527, 6692.196936367667, 6713.2279787824045, 6723.361280678426, 6633.170853643294, 6634.568753031038, 6635.701393437307, 6636.104125942936, 6639.0, 6177.722002509898, 6302.180716506825, 6538.1500404947055, 6615.206175258903, 6631.86736265272, 6392.64840433762, 6399.104125422537, 6405.647689376942, 6414.61512309263, 6421.0, 6348.77779277723, 6349.841253968688, 6366.872662546816, 6372.36276372359, 6377.8952945526935, 6461.19235095613, 6630.436412904957, 6658.966705166443, 6691.76578819739, 6702.966485167543, 4354.760488173054, 4373.322135069069, 4377.4528183977, 4381.430414046281, 4382.05785756064, 6474.514411419068, 6480.25477070143, 6484.675766211576, 6486.643234621953, 6488.870222595616, 6078.118672792332, 6249.0, 6298.937010630018, 6372.58578192416, 6378.74485020594, 6265.655388953652, 6272.874542509216, 6277.246730392382, 6284.057391391328, 6285.717142728497, 6170.197874276315, 6173.41352571505, 6173.567850250619, 6178.938210617836, 6181.505479561534, 6217.906731399123, 6306.243250809932, 6311.905321420274, 6314.936850631619, 6314.968425157845, 6138.662373569497, 6150.661713605616, 6152.876942461216, 6155.538334624832, 6166.475849552839], "unit": "score", "name": "prototype.html", "value": 4712.191761815809}, {"lowerIsBetter": false, "replicates": [692.1313751242192, 726.7746998430487, 799.9400044996626, 804.8390321935615, 869.6564856881528, 12584.81122783159, 12601.0, 12645.051621128407, 12703.809442858364, 12810.167339122961, 12222.877771222285, 12423.0, 12508.124431289812, 12515.061370397234, 12819.102662813606, 666.7233098264214, 677.7627830259419, 797.9880301795492, 807.7859367267679, 809.704457872878, 785.1089013969157, 803.5781214862186, 810.3760104719363, 810.5501446697081, 810.8986376702912, 841.7558907916697, 852.86780549015, 857.669797128107, 857.7126662568047, 857.8455877941968, 683.6035099642221, 696.7143471176844, 829.1004260377498, 850.1625898489982, 851.5061264466625, 621.6922623301449, 621.8911690454153, 622.4615707413101, 623.0871772852747, 623.3268070483912, 13484.528041518499, 13493.595192144252, 13603.387847546885, 13615.455381784717, 13621.931890340584, 11569.553805774278, 11832.0, 11939.164258501909, 12077.275363478131, 12539.561115360919, 9443.102905223992, 9870.9506452468, 9917.851232231522, 10281.89718102817, 10704.518296676668, 3577.749557530974, 3600.6579374959338, 3602.9279414411567, 3675.3568125578186, 3703.8518459261595, 46575.30137047947, 47233.29150062717, 47258.81852953669, 47417.76291118557, 47437.76281118607, 9823.950880245553, 9835.63996565023, 9994.200463962865, 10209.183265338756, 10314.226433017553, 17469.65060698779, 17489.125543722763, 17514.56213594645, 17527.824721752873, 17550.561235969202, 7194.604296763729, 7290.3438690518105, 7370.96314518424, 7371.373433258126, 7455.888161677579, 4208.894777630584, 4227.3447615619625, 4271.594198551133, 4312.482502099768, 4366.366876802846, 2978.3745413462984, 2985.626796650419, 2985.925351866221, 3025.848707564613, 3065.708757668018, 529.5260741636214, 537.9515843574097, 538.4991957479582, 545.7871430142247, 547.7535109200876, 596.2040675697905, 623.6663385088956, 628.7736414890636, 660.9655888534525, 695.5478938689891, 8334.916650833535, 8592.269657079094, 8620.267277281377, 8743.256823170103, 8877.201051905231, 571.4970825673381, 639.2424976402978, 646.2568046746186, 657.3098246840798, 694.6179601219309, 4006.1186538961383, 4035.1929614077303, 4047.817848196838, 4092.508898932147, 4292.678049146264, 50925.745371272904, 51656.225156622684, 51974.740126299126, 52316.73841630767, 52340.0, 47994.76002619965, 48726.0, 49127.75436122868, 49150.26274605884, 49427.752861236186, 42173.367399489034, 43625.34561981573, 43688.12623747507, 44599.55400445954, 44698.77650611726, 8010.0, 8239.546824924686, 8307.916920830714, 8321.791955201168, 8438.367122465963, 32572.83713581417, 33197.66802331946, 33341.0, 33521.0, 33649.32701346008, 38598.80700596479, 39151.608483914795, 42607.57392426036, 42907.7854610725, 43215.35176972411, 10121.342112762646, 10142.0, 10236.0, 10251.84622230682, 10413.375197488174, 11134.721631959266, 11166.274192177483, 11429.942850286028, 11668.649940501798, 11777.057835373322, 10439.269251152651, 10757.354558726502, 10851.945740271249, 10871.0, 10999.835002475129, 10231.386116833013, 10481.161507079567, 10635.574577016832, 10678.62624808128, 11053.944730276296, 10550.788984220426, 10865.760937305247, 10920.945395272973, 10957.780844383227, 10982.725431864268, 9232.399894006869, 9468.810623787347, 9536.189423899046, 9625.374350667184, 9947.651832185838, 8062.516249025077, 8664.0, 8822.735317940473, 9495.14543691071, 9535.618575256913], "unit": "score", "name": "yui.html", "value": 6091.699061190856}], "name": "dromaeo_css", "value": 6721.981511117285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 112.0, 112.0, 102.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 151.0, 162.0, 126.0, 153.0, 160.0, 126.0, 161.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 158.0, 160.0, 165.0, 160.0, 160.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 87.0, 91.0, 71.0, 72.0, 72.0, 106.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [95.0, 104.0, 148.0, 96.0, 96.0, 96.0, 137.0, 97.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0, 68.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 94.0, 85.0, 87.0, 87.0, 86.0, 86.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 119.0, 117.0, 117.0, 120.0, 116.0, 117.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 157.0, 168.0, 159.0, 146.0, 156.0, 159.0, 154.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.5}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 75.0, 74.0, 72.0, 70.0, 71.0, 72.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1515.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [191.35093761959433], "unit": "score", "name": "DeltaBlue", "value": 345.53266799999994}, {"lowerIsBetter": false, "replicates": [287.35632183908046], "unit": "score", "name": "Encrypt", "value": 926.3098800000001}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [612.4694376528117], "unit": "score", "name": "Splay", "value": 133.0531696606787}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20890.258882466533}]} 06:06:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20890.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6721.98"}}} 06:06:27 INFO - Return code: 0 06:06:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:06:27 INFO - # TBPL SUCCESS # 06:06:27 INFO - Running post-action listener: _resource_record_post_action 06:06:27 INFO - Running post-run listener: _resource_record_post_run 06:06:28 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 555036672; Read time: 0; Write time: 515184 06:06:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245030912; Read time: 0; Write time: 306444 06:06:28 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 309141504; Read time: 0; Write time: 208700 06:06:28 INFO - Running post-run listener: _upload_blobber_files 06:06:28 INFO - Blob upload gear active. 06:06:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:06:28 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:06:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:06:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:06:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:29 INFO - (blobuploader) - INFO - Done attempting. 06:06:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:30 INFO - (blobuploader) - INFO - Done attempting. 06:06:30 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:30 INFO - Return code: 0 06:06:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:06:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dbd3fe56643c40191b600004027b5c19fa9f7a89ce624c0f32449153a2865d509b07ae1c2e873ab8aeb80bebee5dbe6c8428fe4c805a522dd17e79b7342634", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a610895f0281e4c1b5a74a1a7c380e25e214b549c71dece4dcbe43c7c090c4b876defdaa1aa39c0870ce5dae6efc4f210acb3a263b5201c191ea10de4cbdc7f"} 06:06:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:06:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:06:30 INFO - Contents: 06:06:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dbd3fe56643c40191b600004027b5c19fa9f7a89ce624c0f32449153a2865d509b07ae1c2e873ab8aeb80bebee5dbe6c8428fe4c805a522dd17e79b7342634", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a610895f0281e4c1b5a74a1a7c380e25e214b549c71dece4dcbe43c7c090c4b876defdaa1aa39c0870ce5dae6efc4f210acb3a263b5201c191ea10de4cbdc7f"} 06:06:30 INFO - Copying logs to upload dir... 06:06:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.328210 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-06 06:06:30.785244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:30.788484) ========= 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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5dbd3fe56643c40191b600004027b5c19fa9f7a89ce624c0f32449153a2865d509b07ae1c2e873ab8aeb80bebee5dbe6c8428fe4c805a522dd17e79b7342634", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a610895f0281e4c1b5a74a1a7c380e25e214b549c71dece4dcbe43c7c090c4b876defdaa1aa39c0870ce5dae6efc4f210acb3a263b5201c191ea10de4cbdc7f"} build_url:https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/YAWu_D-URAGyAq9xYSF6Sg/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/Firefox/sha512/c5dbd3fe56643c40191b600004027b5c19fa9f7a89ce624c0f32449153a2865d509b07ae1c2e873ab8aeb80bebee5dbe6c8428fe4c805a522dd17e79b7342634", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a610895f0281e4c1b5a74a1a7c380e25e214b549c71dece4dcbe43c7c090c4b876defdaa1aa39c0870ce5dae6efc4f210acb3a263b5201c191ea10de4cbdc7f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:30.813766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:30.814114) ========= 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=4dd8011cc2821079d74a932a000001ae-1452085789.692530-202512556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 06:06:30.899087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 06:06:30.899422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 06:06:30.899789) ========= ========= Total master_lag: 0.25 =========