builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1450369419.0 results: success (0) buildid: 20151217053001 builduid: a4f117cf58dc42f9b1175f222e58469e revision: a9eaed26451a0381ed8a599597aa1c8629a2f3d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:38.999743) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.000280) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.000588) ========= 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006415 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.028294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.028595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.041975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.042484) ========= 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.091706) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.092011) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.092372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.092674) ========= 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 08:23:39-- 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% 225M=0s 2015-12-17 08:23:39 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.295423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.295750) ========= 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.346463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.347148) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a9eaed26451a0381ed8a599597aa1c8629a2f3d1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a9eaed26451a0381ed8a599597aa1c8629a2f3d1 --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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 08:23:39,609 truncating revision to first 12 chars 2015-12-17 08:23:39,609 Setting DEBUG logging. 2015-12-17 08:23:39,609 attempt 1/10 2015-12-17 08:23:39,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a9eaed26451a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 08:23:39,856 unpacking tar archive at: fx-team-a9eaed26451a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.508699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.869265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.869564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.877385) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.877760) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:23:39.878214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-17 08:23:39.878504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:23:40 INFO - MultiFileLogger online at 20151217 08:23:40 in /builds/slave/test-pgo 08:23:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:23:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:23:40 INFO - {'append_to_log': False, 08:23:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:23:40 INFO - 'blob_upload_branch': 'Fx-Team', 08:23:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:23:40 INFO - 'branch': 'Fx-Team', 08:23:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:23:40 INFO - 'config_files': ('talos/linux_config.py',), 08:23:40 INFO - 'default_actions': ('clobber', 08:23:40 INFO - 'read-buildbot-config', 08:23:40 INFO - 'download-and-extract', 08:23:40 INFO - 'populate-webroot', 08:23:40 INFO - 'create-virtualenv', 08:23:40 INFO - 'install', 08:23:40 INFO - 'run-tests'), 08:23:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:23:40 INFO - 'download_minidump_stackwalk': True, 08:23:40 INFO - 'download_symbols': 'ondemand', 08:23:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:23:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:23:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:23:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:23:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:23:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:23:40 INFO - 'installer_path': 'installer.exe', 08:23:40 INFO - 'log_level': 'info', 08:23:40 INFO - 'log_name': 'talos', 08:23:40 INFO - 'log_to_console': True, 08:23:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:23:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:23:40 INFO - 'opt_config_files': (), 08:23:40 INFO - 'pip_index': False, 08:23:40 INFO - 'sps_profile': False, 08:23:40 INFO - 'sps_profile_interval': 0, 08:23:40 INFO - 'suite': 'dromaeojs', 08:23:40 INFO - 'system_bits': '64', 08:23:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:23:40 INFO - 'title': 'talos-linux64-ix-016', 08:23:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:23:40 INFO - 'use_talos_json': True, 08:23:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:23:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:23:40 INFO - 'work_dir': 'build'} 08:23:40 INFO - ##### 08:23:40 INFO - ##### Running clobber step. 08:23:40 INFO - ##### 08:23:40 INFO - Running pre-action listener: _resource_record_pre_action 08:23:40 INFO - Running main action method: clobber 08:23:40 INFO - rmtree: /builds/slave/test-pgo/build 08:23:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:23:41 INFO - Running post-action listener: _resource_record_post_action 08:23:41 INFO - ##### 08:23:41 INFO - ##### Running read-buildbot-config step. 08:23:41 INFO - ##### 08:23:41 INFO - Running pre-action listener: _resource_record_pre_action 08:23:41 INFO - Running main action method: read_buildbot_config 08:23:41 INFO - Using buildbot properties: 08:23:41 INFO - { 08:23:41 INFO - "project": "", 08:23:41 INFO - "product": "firefox", 08:23:41 INFO - "script_repo_revision": "production", 08:23:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:23:41 INFO - "repository": "", 08:23:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:23:41 INFO - "buildid": "20151217053001", 08:23:41 INFO - "pgo_build": "True", 08:23:41 INFO - "basedir": "/builds/slave/test-pgo", 08:23:41 INFO - "buildnumber": 841, 08:23:41 INFO - "slavename": "talos-linux64-ix-016", 08:23:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:23:41 INFO - "platform": "ubuntu64_hw", 08:23:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:23:41 INFO - "branch": "fx-team", 08:23:41 INFO - "repo_path": "integration/fx-team", 08:23:41 INFO - "revision": "a9eaed26451a0381ed8a599597aa1c8629a2f3d1", 08:23:41 INFO - "stage_platform": "linux64-pgo", 08:23:41 INFO - "builduid": "a4f117cf58dc42f9b1175f222e58469e", 08:23:41 INFO - "slavebuilddir": "test" 08:23:41 INFO - } 08:23:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:23:41 INFO - Running post-action listener: _resource_record_post_action 08:23:41 INFO - ##### 08:23:41 INFO - ##### Running download-and-extract step. 08:23:41 INFO - ##### 08:23:41 INFO - Running pre-action listener: _resource_record_pre_action 08:23:41 INFO - Running main action method: download_and_extract 08:23:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:23:41 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')]} 08:23:41 INFO - https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/test_packages.json 08:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/test_packages.json 08:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:23:41 INFO - Downloaded 1302 bytes. 08:23:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:23:41 INFO - Using the following test package requirements: 08:23:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:23:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'jsshell-linux-x86_64.zip'], 08:23:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:23:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:23:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:23:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:23:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:23:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:23:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:23:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:23:41 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')]} 08:23:41 INFO - https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:23:55 INFO - Downloaded 23119726 bytes. 08:23:55 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 08:23:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:23:55 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 08:23:56 INFO - Return code: 0 08:23:56 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 08:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:56 INFO - https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:23:58 INFO - Downloaded 23119726 bytes. 08:23:58 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 08:23:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:23:58 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 08:24:00 INFO - Return code: 0 08:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:00 INFO - https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:24:01 INFO - Downloaded 11132039 bytes. 08:24:01 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 08:24:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:01 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 08:24:01 INFO - Return code: 0 08:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:01 INFO - https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/g6f9hYk8T0yZYQSaZ8llyA/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 08:24:03 INFO - Downloaded 54641188 bytes. 08:24:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:24:03 INFO - mkdir: /builds/slave/test-pgo/properties 08:24:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:24:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:24:03 INFO - Contents: 08:24:03 INFO - build_url:https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:24:03 INFO - Running post-action listener: _resource_record_post_action 08:24:03 INFO - Running post-action listener: set_extra_try_arguments 08:24:03 INFO - ##### 08:24:03 INFO - ##### Running populate-webroot step. 08:24:03 INFO - ##### 08:24:03 INFO - Running pre-action listener: _resource_record_pre_action 08:24:03 INFO - Running main action method: populate_webroot 08:24:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:03 INFO - '--tppagecycles', 08:24:03 INFO - '7'], 08:24:03 INFO - 'tests': ['tsvgm']}}, 08:24:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:24:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:24:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:24:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'tests': ['damp', 'tps']}, 08:24:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['damp', 'tps']}, 08:24:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:24:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:03 INFO - 'other': {'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other_l64': {'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'other_nol64': {'tests': ['a11yr', 08:24:03 INFO - 'ts_paint', 08:24:03 INFO - 'tpaint', 08:24:03 INFO - 'sessionrestore', 08:24:03 INFO - 'sessionrestore_no_auto_restore']}, 08:24:03 INFO - 'svgr': {'tests': ['tsvgx', 08:24:03 INFO - 'tsvgr_opacity', 08:24:03 INFO - 'tart', 08:24:03 INFO - 'tscrollx', 08:24:03 INFO - 'cart']}, 08:24:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tsvgx', 08:24:03 INFO - 'tsvgr_opacity', 08:24:03 INFO - 'tart', 08:24:03 INFO - 'tscrollx', 08:24:03 INFO - 'cart']}, 08:24:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'tests': ['tp5o']}, 08:24:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s'], 08:24:03 INFO - 'tests': ['tp5o']}, 08:24:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--xperf_path', 08:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:03 INFO - 'tests': ['tp5n']}, 08:24:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:03 INFO - 'talos_options': ['--e10s', 08:24:03 INFO - '--xperf_path', 08:24:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:03 INFO - 'tests': ['tp5n']}}, 08:24:03 INFO - 'talos.zip': {'path': '', 08:24:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:03 INFO - Running post-action listener: _resource_record_post_action 08:24:03 INFO - ##### 08:24:03 INFO - ##### Running create-virtualenv step. 08:24:03 INFO - ##### 08:24:03 INFO - Running pre-action listener: _resource_record_pre_action 08:24:03 INFO - Running main action method: create_virtualenv 08:24:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:24:03 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 08:24:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:24:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:03 INFO - Using real prefix '/usr' 08:24:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:24:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:05 INFO - Installing pip.................done. 08:24:05 INFO - Return code: 0 08:24:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:24:05 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')]} 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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')]} 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:05 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 08:24:05 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 08:24:05 INFO - Using env: {'DISPLAY': ':0', 08:24:05 INFO - 'HOME': '/home/cltbld', 08:24:05 INFO - 'LANG': 'en_US.UTF-8', 08:24:05 INFO - 'LANGUAGE': 'en_US:en', 08:24:05 INFO - 'LOGNAME': 'cltbld', 08:24:05 INFO - 'MAIL': '/var/mail/cltbld', 08:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:05 INFO - 'MOZ_NO_REMOTE': '1', 08:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:05 INFO - 'NO_EM_RESTART': '1', 08:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:05 INFO - 'SHELL': '/bin/bash', 08:24:05 INFO - 'SHLVL': '1', 08:24:05 INFO - 'TERM': 'linux', 08:24:05 INFO - 'TMOUT': '86400', 08:24:05 INFO - 'USER': 'cltbld', 08:24:05 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:05 INFO - '_': '/tools/buildbot/bin/python'} 08:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:05 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 08:24:05 INFO - Cleaning up... 08:24:05 INFO - Return code: 0 08:24:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:24:05 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')]} 08:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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')]} 08:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:05 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:05 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 08:24:05 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 08:24:05 INFO - Using env: {'DISPLAY': ':0', 08:24:05 INFO - 'HOME': '/home/cltbld', 08:24:05 INFO - 'LANG': 'en_US.UTF-8', 08:24:05 INFO - 'LANGUAGE': 'en_US:en', 08:24:05 INFO - 'LOGNAME': 'cltbld', 08:24:05 INFO - 'MAIL': '/var/mail/cltbld', 08:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:05 INFO - 'MOZ_NO_REMOTE': '1', 08:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:05 INFO - 'NO_EM_RESTART': '1', 08:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:05 INFO - 'SHELL': '/bin/bash', 08:24:05 INFO - 'SHLVL': '1', 08:24:05 INFO - 'TERM': 'linux', 08:24:05 INFO - 'TMOUT': '86400', 08:24:05 INFO - 'USER': 'cltbld', 08:24:05 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:05 INFO - '_': '/tools/buildbot/bin/python'} 08:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:06 INFO - Downloading/unpacking psutil>=0.7.1 08:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:07 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:24:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:24:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:07 INFO - Installing collected packages: psutil 08:24:07 INFO - Running setup.py install for psutil 08:24:07 INFO - building 'psutil._psutil_linux' extension 08:24:07 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 08:24:08 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 08:24:08 INFO - building 'psutil._psutil_posix' extension 08:24:08 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 08:24:08 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 08:24:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:08 INFO - Successfully installed psutil 08:24:08 INFO - Cleaning up... 08:24:08 INFO - Return code: 0 08:24:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:08 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:08 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 08:24:08 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 08:24:08 INFO - Using env: {'DISPLAY': ':0', 08:24:08 INFO - 'HOME': '/home/cltbld', 08:24:08 INFO - 'LANG': 'en_US.UTF-8', 08:24:08 INFO - 'LANGUAGE': 'en_US:en', 08:24:08 INFO - 'LOGNAME': 'cltbld', 08:24:08 INFO - 'MAIL': '/var/mail/cltbld', 08:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:08 INFO - 'MOZ_NO_REMOTE': '1', 08:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:08 INFO - 'NO_EM_RESTART': '1', 08:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:08 INFO - 'SHELL': '/bin/bash', 08:24:08 INFO - 'SHLVL': '1', 08:24:08 INFO - 'TERM': 'linux', 08:24:08 INFO - 'TMOUT': '86400', 08:24:08 INFO - 'USER': 'cltbld', 08:24:08 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:08 INFO - '_': '/tools/buildbot/bin/python'} 08:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:24:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:24:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:24:10 INFO - Installing collected packages: mozsystemmonitor 08:24:10 INFO - Running setup.py install for mozsystemmonitor 08:24:10 INFO - Successfully installed mozsystemmonitor 08:24:10 INFO - Cleaning up... 08:24:10 INFO - Return code: 0 08:24:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:10 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:10 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 08:24:10 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 08:24:10 INFO - Using env: {'DISPLAY': ':0', 08:24:10 INFO - 'HOME': '/home/cltbld', 08:24:10 INFO - 'LANG': 'en_US.UTF-8', 08:24:10 INFO - 'LANGUAGE': 'en_US:en', 08:24:10 INFO - 'LOGNAME': 'cltbld', 08:24:10 INFO - 'MAIL': '/var/mail/cltbld', 08:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:10 INFO - 'MOZ_NO_REMOTE': '1', 08:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:10 INFO - 'NO_EM_RESTART': '1', 08:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:10 INFO - 'SHELL': '/bin/bash', 08:24:10 INFO - 'SHLVL': '1', 08:24:10 INFO - 'TERM': 'linux', 08:24:10 INFO - 'TMOUT': '86400', 08:24:10 INFO - 'USER': 'cltbld', 08:24:10 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:10 INFO - '_': '/tools/buildbot/bin/python'} 08:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:10 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 08:24:10 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 08:24:10 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 08:24:10 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 08:24:10 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 08:24:10 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 08:24:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:24:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:24:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:24:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 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 08:24:12 INFO - Downloading docopt-0.6.1.tar.gz 08:24:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:24:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:13 INFO - Running setup.py install for blobuploader 08:24:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:24:13 INFO - Running setup.py install for requests 08:24:13 INFO - Running setup.py install for docopt 08:24:13 INFO - Successfully installed blobuploader requests docopt 08:24:13 INFO - Cleaning up... 08:24:13 INFO - Return code: 0 08:24:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:13 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:13 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 08:24:13 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 08:24:13 INFO - Using env: {'DISPLAY': ':0', 08:24:13 INFO - 'HOME': '/home/cltbld', 08:24:13 INFO - 'LANG': 'en_US.UTF-8', 08:24:13 INFO - 'LANGUAGE': 'en_US:en', 08:24:13 INFO - 'LOGNAME': 'cltbld', 08:24:13 INFO - 'MAIL': '/var/mail/cltbld', 08:24:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:13 INFO - 'MOZ_NO_REMOTE': '1', 08:24:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:13 INFO - 'NO_EM_RESTART': '1', 08:24:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:13 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:13 INFO - 'SHELL': '/bin/bash', 08:24:13 INFO - 'SHLVL': '1', 08:24:13 INFO - 'TERM': 'linux', 08:24:13 INFO - 'TMOUT': '86400', 08:24:13 INFO - 'USER': 'cltbld', 08:24:13 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:13 INFO - '_': '/tools/buildbot/bin/python'} 08:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:24:13 INFO - Running setup.py (path:/tmp/pip-9LJVDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:24:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:24:13 INFO - Running setup.py (path:/tmp/pip-ZgZw8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:24:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:24:13 INFO - Running setup.py (path:/tmp/pip-RW2e8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:24:14 INFO - Running setup.py (path:/tmp/pip-09M_3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:24:14 INFO - Running setup.py (path:/tmp/pip-swkN0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:24:14 INFO - Running setup.py (path:/tmp/pip-3PdPAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:24:14 INFO - Running setup.py (path:/tmp/pip-r8HOU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:24:14 INFO - Running setup.py (path:/tmp/pip-KJ8fSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:24:14 INFO - Running setup.py (path:/tmp/pip-eFVgmb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:24:14 INFO - Running setup.py (path:/tmp/pip-OdO_dC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:24:14 INFO - Running setup.py (path:/tmp/pip-nw94xH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:24:14 INFO - Running setup.py (path:/tmp/pip-BWkhjU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:24:14 INFO - Running setup.py (path:/tmp/pip-i0H8Nq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:24:14 INFO - Running setup.py (path:/tmp/pip-jwI8LN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:24:14 INFO - Running setup.py (path:/tmp/pip-H2r9rE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:24:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:24:14 INFO - Running setup.py (path:/tmp/pip-jMoly5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:24:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:24:15 INFO - Running setup.py (path:/tmp/pip-G4NO3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:24:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:15 INFO - Running setup.py install for manifestparser 08:24:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Running setup.py install for mozcrash 08:24:15 INFO - Running setup.py install for mozdebug 08:24:15 INFO - Running setup.py install for mozdevice 08:24:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Running setup.py install for mozfile 08:24:15 INFO - Running setup.py install for mozhttpd 08:24:15 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Running setup.py install for mozinfo 08:24:15 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Running setup.py install for mozInstall 08:24:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:24:15 INFO - Running setup.py install for mozleak 08:24:15 INFO - Running setup.py install for mozlog 08:24:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Running setup.py install for moznetwork 08:24:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Running setup.py install for mozprocess 08:24:16 INFO - Running setup.py install for mozprofile 08:24:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Running setup.py install for mozrunner 08:24:16 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Running setup.py install for mozscreenshot 08:24:16 INFO - Running setup.py install for moztest 08:24:16 INFO - Running setup.py install for mozversion 08:24:16 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:24:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:16 INFO - Cleaning up... 08:24:16 INFO - Return code: 0 08:24:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:24: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')]} 08:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:16 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:16 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 08:24:16 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 08:24:16 INFO - Using env: {'DISPLAY': ':0', 08:24:16 INFO - 'HOME': '/home/cltbld', 08:24:16 INFO - 'LANG': 'en_US.UTF-8', 08:24:16 INFO - 'LANGUAGE': 'en_US:en', 08:24:16 INFO - 'LOGNAME': 'cltbld', 08:24:16 INFO - 'MAIL': '/var/mail/cltbld', 08:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:16 INFO - 'MOZ_NO_REMOTE': '1', 08:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:16 INFO - 'NO_EM_RESTART': '1', 08:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:16 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:16 INFO - 'SHELL': '/bin/bash', 08:24:16 INFO - 'SHLVL': '1', 08:24:16 INFO - 'TERM': 'linux', 08:24:16 INFO - 'TMOUT': '86400', 08:24:16 INFO - 'USER': 'cltbld', 08:24:16 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:16 INFO - '_': '/tools/buildbot/bin/python'} 08:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:24:17 INFO - Running setup.py (path:/tmp/pip-sLe9vE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:24:17 INFO - Running setup.py (path:/tmp/pip-Xi1ou_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:24:17 INFO - Running setup.py (path:/tmp/pip-E226ko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:24:17 INFO - Running setup.py (path:/tmp/pip-z4reUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:24:17 INFO - Running setup.py (path:/tmp/pip-bJUNF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:24:17 INFO - Running setup.py (path:/tmp/pip-wM_ZrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:24:17 INFO - Running setup.py (path:/tmp/pip-cDq0_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:24:17 INFO - Running setup.py (path:/tmp/pip-UIlQnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:24:17 INFO - Running setup.py (path:/tmp/pip-Xzm6fv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:24:17 INFO - Running setup.py (path:/tmp/pip-RP7DTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:24:17 INFO - Running setup.py (path:/tmp/pip-IAWRdh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:24:17 INFO - Running setup.py (path:/tmp/pip-kAD6xR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:24:17 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)) 08:24:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:24:17 INFO - Running setup.py (path:/tmp/pip-fHNQ79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:24:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:24:18 INFO - Running setup.py (path:/tmp/pip-pbREIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:24:18 INFO - Running setup.py (path:/tmp/pip-L2aswh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:24:18 INFO - Running setup.py (path:/tmp/pip-4ool4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:24:18 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)) 08:24:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:24:18 INFO - Running setup.py (path:/tmp/pip-f2CVm0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 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)) 08:24:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:18 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 08:24:18 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 08:24:18 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 08:24:18 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 08:24:18 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 08:24:18 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 08:24:20 INFO - Downloading blessings-1.5.1.tar.gz 08:24:20 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 08:24:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:20 INFO - Installing collected packages: blessings 08:24:20 INFO - Running setup.py install for blessings 08:24:20 INFO - Successfully installed blessings 08:24:20 INFO - Cleaning up... 08:24:20 INFO - Return code: 0 08:24:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:24:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:24:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:24:20 INFO - Reading from file tmpfile_stdout 08:24:20 INFO - Current package versions: 08:24:20 INFO - argparse == 1.2.1 08:24:20 INFO - blessings == 1.5.1 08:24:20 INFO - blobuploader == 1.2.4 08:24:20 INFO - docopt == 0.6.1 08:24:20 INFO - manifestparser == 1.1 08:24:20 INFO - mozInstall == 1.12 08:24:20 INFO - mozcrash == 0.16 08:24:20 INFO - mozdebug == 0.1 08:24:20 INFO - mozdevice == 0.47 08:24:20 INFO - mozfile == 1.2 08:24:20 INFO - mozhttpd == 0.7 08:24:20 INFO - mozinfo == 0.9 08:24:20 INFO - mozleak == 0.1 08:24:20 INFO - mozlog == 3.1 08:24:20 INFO - moznetwork == 0.27 08:24:20 INFO - mozprocess == 0.22 08:24:20 INFO - mozprofile == 0.27 08:24:20 INFO - mozrunner == 6.11 08:24:20 INFO - mozscreenshot == 0.1 08:24:20 INFO - mozsystemmonitor == 0.0 08:24:20 INFO - moztest == 0.7 08:24:20 INFO - mozversion == 1.4 08:24:20 INFO - psutil == 3.1.1 08:24:20 INFO - requests == 1.2.3 08:24:20 INFO - wsgiref == 0.1.2 08:24:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:24:20 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')]} 08:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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')]} 08:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:20 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 08:24:20 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 08:24:20 INFO - Using env: {'DISPLAY': ':0', 08:24:20 INFO - 'HOME': '/home/cltbld', 08:24:20 INFO - 'LANG': 'en_US.UTF-8', 08:24:20 INFO - 'LANGUAGE': 'en_US:en', 08:24:20 INFO - 'LOGNAME': 'cltbld', 08:24:20 INFO - 'MAIL': '/var/mail/cltbld', 08:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:20 INFO - 'MOZ_NO_REMOTE': '1', 08:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:20 INFO - 'NO_EM_RESTART': '1', 08:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:20 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:20 INFO - 'SHELL': '/bin/bash', 08:24:20 INFO - 'SHLVL': '1', 08:24:20 INFO - 'TERM': 'linux', 08:24:20 INFO - 'TMOUT': '86400', 08:24:20 INFO - 'USER': 'cltbld', 08:24:20 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:20 INFO - '_': '/tools/buildbot/bin/python'} 08:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:24:20 INFO - Cleaning up... 08:24:20 INFO - Return code: 0 08:24:20 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:24:20 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')]} 08:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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')]} 08:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:20 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:20 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 08:24:20 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 08:24:20 INFO - Using env: {'DISPLAY': ':0', 08:24:20 INFO - 'HOME': '/home/cltbld', 08:24:20 INFO - 'LANG': 'en_US.UTF-8', 08:24:20 INFO - 'LANGUAGE': 'en_US:en', 08:24:20 INFO - 'LOGNAME': 'cltbld', 08:24:20 INFO - 'MAIL': '/var/mail/cltbld', 08:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:20 INFO - 'MOZ_NO_REMOTE': '1', 08:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:20 INFO - 'NO_EM_RESTART': '1', 08:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:20 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:20 INFO - 'SHELL': '/bin/bash', 08:24:20 INFO - 'SHLVL': '1', 08:24:20 INFO - 'TERM': 'linux', 08:24:20 INFO - 'TMOUT': '86400', 08:24:20 INFO - 'USER': 'cltbld', 08:24:20 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:20 INFO - '_': '/tools/buildbot/bin/python'} 08:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:20 INFO - Downloading/unpacking jsonschema 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:20 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 08:24:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:24:22 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 08:24:22 INFO - Downloading/unpacking functools32 (from jsonschema) 08:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:24:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:24:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:24:22 INFO - warning: no files found matching '*.txt' 08:24:22 INFO - no previously-included directories found matching 'build' 08:24:22 INFO - no previously-included directories found matching 'dist' 08:24:22 INFO - no previously-included directories found matching '.git*' 08:24:22 INFO - Installing collected packages: jsonschema, functools32 08:24:22 INFO - Running setup.py install for functools32 08:24:22 INFO - warning: no files found matching '*.txt' 08:24:22 INFO - no previously-included directories found matching 'build' 08:24:22 INFO - no previously-included directories found matching 'dist' 08:24:22 INFO - no previously-included directories found matching '.git*' 08:24:22 INFO - Successfully installed jsonschema functools32 08:24:22 INFO - Cleaning up... 08:24:23 INFO - Return code: 0 08:24:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:24:23 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')]} 08:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:23 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')]} 08:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:23 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 0x7faa764b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, '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': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', '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 08:24:23 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 08:24:23 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 08:24:23 INFO - Using env: {'DISPLAY': ':0', 08:24:23 INFO - 'HOME': '/home/cltbld', 08:24:23 INFO - 'LANG': 'en_US.UTF-8', 08:24:23 INFO - 'LANGUAGE': 'en_US:en', 08:24:23 INFO - 'LOGNAME': 'cltbld', 08:24:23 INFO - 'MAIL': '/var/mail/cltbld', 08:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:23 INFO - 'MOZ_NO_REMOTE': '1', 08:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:23 INFO - 'NO_EM_RESTART': '1', 08:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:23 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:23 INFO - 'SHELL': '/bin/bash', 08:24:23 INFO - 'SHLVL': '1', 08:24:23 INFO - 'TERM': 'linux', 08:24:23 INFO - 'TMOUT': '86400', 08:24:23 INFO - 'USER': 'cltbld', 08:24:23 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:23 INFO - '_': '/tools/buildbot/bin/python'} 08:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:23 INFO - Downloading/unpacking flake8 08:24:23 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 08:24:23 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 08:24:23 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 08:24:23 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 08:24:23 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 08:24:23 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 08:24:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:24:24 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 08:24:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:24:25 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 08:24:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 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 08:24:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:24:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:24:25 INFO - no previously-included directories found matching 'docs/_build' 08:24:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:24:25 INFO - Running setup.py install for pep8 08:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:24:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:24:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:24:25 INFO - no previously-included directories found matching 'docs/_build' 08:24:25 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:24:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:24:25 INFO - Cleaning up... 08:24:25 INFO - Return code: 0 08:24:25 INFO - Running post-action listener: _resource_record_post_action 08:24:25 INFO - Running post-action listener: _start_resource_monitoring 08:24:25 INFO - Starting resource monitoring. 08:24:25 INFO - ##### 08:24:25 INFO - ##### Running install step. 08:24:25 INFO - ##### 08:24:25 INFO - Running pre-action listener: _resource_record_pre_action 08:24:25 INFO - Running main action method: install 08:24:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:24:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:24:26 INFO - Reading from file tmpfile_stdout 08:24:26 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:24:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:24:26 INFO - Reading from file tmpfile_stdout 08:24:26 INFO - Output received: 08:24:26 INFO - Usage: mozinstall [options] installer 08:24:26 INFO - Options: 08:24:26 INFO - -h, --help show this help message and exit 08:24:26 INFO - -d DEST, --destination=DEST 08:24:26 INFO - Directory to install application into. [default: 08:24:26 INFO - "/builds/slave/test-pgo"] 08:24:26 INFO - --app=APP Application being installed. [default: firefox] 08:24:26 INFO - mkdir: /builds/slave/test-pgo/build/application 08:24:26 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'] 08:24:26 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 08:24:41 INFO - Reading from file tmpfile_stdout 08:24:41 INFO - Output received: 08:24:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:24:41 INFO - Running post-action listener: _resource_record_post_action 08:24:41 INFO - ##### 08:24:41 INFO - ##### Running run-tests step. 08:24:41 INFO - ##### 08:24:41 INFO - Running pre-action listener: _resource_record_pre_action 08:24:41 INFO - Running main action method: run_tests 08:24:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:24:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:24:41 INFO - Python 2.7.3 08:24:41 INFO - Return code: 0 08:24:41 INFO - grabbing minidump binary from tooltool 08:24:41 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')]} 08:24:41 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 0x26a6350>, '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 0x26a7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:24:41 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 08:24:41 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 08:24:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:41 INFO - Return code: 0 08:24:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:24:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:24:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:24:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:24:42 INFO - Return code: 0 08:24:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:24:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 08:24:42 INFO - Using env: {'DISPLAY': ':0', 08:24:42 INFO - 'HOME': '/home/cltbld', 08:24:42 INFO - 'LANG': 'en_US.UTF-8', 08:24:42 INFO - 'LANGUAGE': 'en_US:en', 08:24:42 INFO - 'LOGNAME': 'cltbld', 08:24:42 INFO - 'MAIL': '/var/mail/cltbld', 08:24:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:24:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:42 INFO - 'MOZ_NO_REMOTE': '1', 08:24:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:42 INFO - 'NO_EM_RESTART': '1', 08:24:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:24:42 INFO - 'PWD': '/builds/slave/test-pgo', 08:24:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:24:42 INFO - 'SHELL': '/bin/bash', 08:24:42 INFO - 'SHLVL': '1', 08:24:42 INFO - 'TERM': 'linux', 08:24:42 INFO - 'TMOUT': '86400', 08:24:42 INFO - 'USER': 'cltbld', 08:24:42 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1450361735.998339-246165691', 08:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:42 INFO - '_': '/tools/buildbot/bin/python'} 08:24:42 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 08:24:43 INFO - mozversion INFO | application_buildid: 20151217053001 08:24:43 INFO - mozversion INFO | application_changeset: a9eaed26451a0381ed8a599597aa1c8629a2f3d1 08:24:43 INFO - mozversion INFO | application_display_name: Nightly 08:24:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:43 INFO - mozversion INFO | application_name: Firefox 08:24:43 INFO - mozversion INFO | application_remotingname: firefox 08:24:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:24:43 INFO - mozversion INFO | application_vendor: Mozilla 08:24:43 INFO - mozversion INFO | application_version: 46.0a1 08:24:43 INFO - mozversion INFO | platform_buildid: 20151217053001 08:24:43 INFO - mozversion INFO | platform_changeset: a9eaed26451a0381ed8a599597aa1c8629a2f3d1 08:24:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:24:43 INFO - mozversion INFO | platform_version: 46.0a1 08:24:43 INFO - 2015-12-17 08:24:43,120 DEBUG : using testdate: 1450369483 08:24:43 INFO - 2015-12-17 08:24:43,120 DEBUG : actual date: 1450369483 08:24:43 INFO - 2015-12-17 08:24:43,129 INFO : starting webserver on 'localhost:54295' 08:24:43 INFO - 2015-12-17 08:24:43,130 INFO : Starting test suite talos-linux64-ix-016 08:24:43 INFO - 2015-12-17 08:24:43,130 INFO : Starting test dromaeo_css 08:24:43 INFO - 2015-12-17 08:24:43,130 DEBUG : operating with platform_type : linux_ 08:24:43 INFO - 2015-12-17 08:24:43,131 INFO : Initialising browser for dromaeo_css test... 08:24:43 INFO - 2015-12-17 08:24:43,148 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbNT1sy/profile http://localhost:54295/getInfo.html 08:24:47 INFO - 2015-12-17 08:24:47,192 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:24:47 INFO - 2015-12-17 08:24:47,192 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:24:47 INFO - 2015-12-17 08:24:47,193 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:24:47 INFO - 2015-12-17 08:24:47,193 DEBUG : BROWSER_OUTPUT: __metrics 08:24:47 INFO - 2015-12-17 08:24:47,294 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:24:47 INFO - 2015-12-17 08:24:47,342 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:48 INFO - 2015-12-17 08:24:48,467 INFO : Browser initialized. 08:24:48 INFO - 2015-12-17 08:24:48,468 INFO : Running cycle 1/1 for dromaeo_css test... 08:24:48 INFO - 2015-12-17 08:24:48,468 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbNT1sy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:25:00 INFO - 2015-12-17 08:25:00,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 149991424 08:25:00 INFO - 2015-12-17 08:25:00,270 DEBUG : BROWSER_OUTPUT: 08:25:51 INFO - 2015-12-17 08:25:51,013 DEBUG : BROWSER_OUTPUT: 1450369551012 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] 08:28:00 INFO - 2015-12-17 08:28:00,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54295/tests/dromaeo/cssquery-ext.html) 08:28:01 INFO - 2015-12-17 08:28:01,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 270569472 08:28:01 INFO - 2015-12-17 08:28:01,847 DEBUG : BROWSER_OUTPUT: 08:31:04 INFO - 2015-12-17 08:31:04,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/dromaeo/cssquery-ext.html (next: http://localhost:54295/tests/dromaeo/cssquery-jquery.html) 08:31:04 INFO - 2015-12-17 08:31:04,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 237629440 08:31:04 INFO - 2015-12-17 08:31:04,780 DEBUG : BROWSER_OUTPUT: 08:34:06 INFO - 2015-12-17 08:34:06,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54295/tests/dromaeo/cssquery-mootools.html) 08:34:07 INFO - 2015-12-17 08:34:07,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 230563840 08:34:07 INFO - 2015-12-17 08:34:07,356 DEBUG : BROWSER_OUTPUT: 08:37:09 INFO - 2015-12-17 08:37:09,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54295/tests/dromaeo/cssquery-prototype.html) 08:37:09 INFO - 2015-12-17 08:37:09,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 204283904 08:37:09 INFO - 2015-12-17 08:37:09,826 DEBUG : BROWSER_OUTPUT: 08:40:12 INFO - 2015-12-17 08:40:12,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54295/tests/dromaeo/cssquery-yui.html) 08:40:12 INFO - 2015-12-17 08:40:12,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 213536768 08:40:12 INFO - 2015-12-17 08:40:12,916 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/dromaeo/cssquery-yui.html (next: http://localhost:54295/tests/dromaeo/cssquery-dojo.html) 08:43:15 INFO - 2015-12-17 08:43:15,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 315949056 08:43:15 INFO - 2015-12-17 08:43:15,636 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,638 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:43:15 INFO - 2015-12-17 08:43:15,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:43:15 INFO - 2015-12-17 08:43:15,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:43:15 INFO - 2015-12-17 08:43:15,638 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:43:15 INFO - 2015-12-17 08:43:15,639 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3135.435621588114;3203.6636153203926;3245.140037889958;3252.8048317100975;3255.2024753935284;5154.74226288686;5250.763715632796;5303.89392212156;5365.865853353668;5426.077566813647;5235.293235413227;5261.815836445725;5307.814226502073;5393.1910213468;5402.189671549269;4825.469198388183;4841.951580484203;4851.878703032417;4856.441509226431;4884.072026314989;4934.901301973959;4965.42897566779;4975.626827987898;5034.521720436571;5039.848804535852;4669.136209801164;4758.310045043467;4812.470628230909;4819.084373968934;4823.927641085386;4803.5916947059195;4821.059893320804;4829.154897892855;4847.806087756486;4850.902981940341;4789.305550695164;4801.783919723621;4804.75976201192;4817.56641902227;4818.614510839159;5059.519345662156;5114.05390002847;5159.22611608258;5249.396319423277;5262.500062494057;5734.168545560912;5738.8278351649515;5759.452851979056;5761.337446193699;5764.682942438164;5552.472515111058;5779.595428320019;5784.219130417382;5796.333421656522;5799.18811366409;5203.713795741195;5279.445658205871;5280.392754833167;5283.630145889828;5317.521423071865;5819.301683797971;5826.388229235954;5828.417158284137;5858.53131749459;5864.06175011996;5643.830685079454;5647.152927060892;5653.123765816305;5654.170958800518;5698.971505142447;5384.246205531229;5544.445555444423;5550.333959924835;5569.635439317393;5725.456081672234;5715.114157305624;5731.684757338303;5756.597038207286;5770.826875193751;5776.480116789425;5785.508231800344;5796.42035796417;5800.622959507618;5801.274840644919;5802.4777770000055;4357.586029327209;4439.889002774957;4443.977885086383;4448.5551444855255;4458.308962110878;3922.5685174630767;3943.3493473577114;3963.8612648557164;3979.2041591681777;3992.900177495586;5395.325584301962;5420.376656684532;5427;5433;5435.266239057755;5440.4287549807495;5480.177973303957;5540.833774986757;5658.490735833712;5715.714214289269;5492.231087647732;5496.780128794803;5511.338639363302;5514.448555144453;5529.502344788988;5032.672876263031;5044.268581055726;5058.418281897555;5069.923951140736;5112.054269960069;5742.799002034909;5830.2129212555765;5862.765489380462;5863.736131874076;5940.910886336708;5748.080307150836;5751.97124014394;5752.9712351437975;5771.7114144293455;5827.59206855516;5843;5844.532437405082;5845.795397161079;5852.912206316993;5869.148973398748;5487.2317875496665;5580.888382232414;5619.353774316006;5663.433656634468;5663.773449062156;5707.714614269187;5767.509761670305;5810.244668193108;5812.244408227072;5830.562707797017;5656.066748986371;5673.149027645886;5677.858053548694;5680.630759000652;5691.573132015033;5340.252364668871;5425.565954723534;5445.319335083114;5453.427390124139;5642.379338272869;5559.6664200148125;5576.414476479911;5579.581531385081;5584.888302234014;5588.3573389060775;5681.17622944679;5682.687452190004;5686.60193786431;5690.914636280542;5730.025895597675;5302.7083510405755;5473.2063850742215;5491.148871924858;5566.276384070045;5592.608517403743 08:43:15 INFO - 2015-12-17 08:43:15,641 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.7133574781502;583.5215123598649;593.3117583603022;598.6408155106939;628.9748410063597;30025.849870750644;30683.69316306836;30702.38595228094;30722;30736.38527229457;40111;40593;40612.39081413781;40647.18705625893;40714.38928416076;8878.911210887873;9037.457752534836;9041.186293233608;9041.593128309241;9048.77378065547;7743.651535680908;7915.050193976702;8781.990071141836;8895.28837692983;10631.574737010511;10590;10667.573297068107;10688.198385121146;10694.144468442544;10701.732456688605;10638.095761860252;10739.946300268448;10743.19426043046;10746.677599672023;10759.892401076046;7639.350655194316;7862.2923936845955;10607.575696972111;10857.131429485702;10868.347899126078;39490.60509394898;39830.60169398298;39848.60151398507;39901.20197596032;39917.80041099805;3380.6619338066;3403.6936675699058;3425.9657403425895;3649.908752281188;4037.2964550446213;30175.69824301751;30455.847720761256;30538.236544086576;30618.99589848881;31396;3978.8408463661417;3986.142979259444;4028.798560072014;4067.8983025424304;4075.49056367954;250214;250710;250995;252586;253260.73369633217;53647.73176134095;54601;59295;59759.40240597539;64578;57853.71073144607;57856.71071644699;58115.70942145262;58120.709396452745;58311.416885831444;13770.311484425738;13848.16910985324;13898.722025559635;13912.304384780922;13931.303434828218;10153.187744980383;10158.695239142837;10169.694909152737;10214.233932455096;10230.28388012832;19217;19257.22971081141;19334.419967401;19425.902870485555;19519.902400487907;7200.639968001579;7344.889826652605;7365.226651201654;7472.439567032494;7481.663325150273;896.9461832289953;947.5357075033185;958.1147158882299;975.2929126383457;996.6611352140308;28725.56911646327;28753.712462875104;28913.710862891523;28955.71044289572;29315.85342073276;1028.1620479309338;1033.0805583031108;1077.1113831089226;1104.2601457023814;1129.6102844518628;14714.705705885823;14963.476278330207;15011.549653510412;15144.848551514344;15151.545453636409;304712;306402;307757;308541;308844;51585.7420712894;51768;51855;51891.48108518942;52057.21914171291;1292.8642492538336;1294.5469085819889;1306.9542566010143;1309.12942892977;1311.2329287366806;27342.316442089108;28321.29196770015;28815.42369152647;28893.711062889102;29029;43983.78008109939;44610.55389446194;46376;50098;50902;200162;200968;201177;201836;201875;27997;28101.297467563476;28199.71800281971;28258.576121357786;28271.57592636071;31384.744610215337;33524.329513410084;37279.677425793874;40780;41080;34385.14037149091;36952.63047369492;37150.628493714714;37477.81261093677;37909.241815164096;37273.81363093167;37983.430248545745;38187.2362552753;38251.42622860603;38275.23449531049;35919.461208081375;36381.51523924559;36815;36989;37055.258894822495;31100.533491998092;33848.67124633935;34240.65759342375;34400.82799585986;34416.483752743225;25031.249062528153;25281.87359063193;25414.364640884127;25427.709157772893;25826.225213243633 08:43:15 INFO - 2015-12-17 08:43:15,642 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.6905238863605;353.89206292080905;355.74564186606574;356.3087610036529;357.10901301253375;13705.177689338621;13992.300384980761;16482.505524834243;16512;16898.98606083636;14035.78946315806;14181.290935453238;14863.851361486382;14892.7021459571;14948.476803311887;5262.421133675292;5263.710495922723;5399.865003374927;5411.431799661038;5415.620906536544;3930.862419815307;4042.818073186699;5324.7071411072375;5783.9710801445935;5971.223740913675;5854.677992710421;5891.175235467038;5899.5870289079785;5922.555808314372;5931.051031834907;5757.193992841006;5880.294364676266;5888.852778680546;5890.204822348971;5897.498712609433;5172.663776854492;5186.818461353834;5191.377034755816;5198.558122559587;5210.947890521122;12271.57049503263;12534.74930501385;12588.37058147089;12590.622281331483;19099.140538675794;2079.656856618656;2148.5917675641736;2173.7608863025052;2175.9020844062056;2177.6298029335053;9337.71986840396;9382.85925711115;9523.714288571355;9538;12393.256404615751;1851.6666999940005;1856.3131641292807;1860.7953125156223;1900.4678689966831;1900.8194221548931;57611.711941440444;62603.37396626021;63009.36990630081;63951;64486;10192.745181370377;10287.177025837915;10384.688459346231;10392.948035259775;10432.374057556419;13507.594772156852;13578.117422367515;13639.727205455836;13650.385732642055;13664.316784160752;7094.290570942864;7108.928910710827;7125.92874071263;7144.428445724329;7190.892136617955;6636.30318816527;6699.832504187434;6751.797446076625;6765.492588055916;6796.626185559743;4389.122175564899;4431.556844315543;4461.219286624892;4467.195904737178;4503.617192538671;1669.5074952888926;1717.7938647362396;1761.5508045448585;1767.5404394857173;1840.5950690847992;835.2566216067704;911.0616065452595;945.4563625915126;971.8493633486821;995.5121990224737;16504.917475412545;16829.326826926786;17102.743458848126;17312.134393280285;17471.912640436716;942.236788201559;944.9433034017981;952.8856537215579;962.0043255230803;970.7476056225291;9640.75898102553;9729.756756081155;10035.448050357301;10055.69832905014;10178.643747468803;479140;480371;481122;493954;500552;84028.57985710155;84969.57515212384;85396;86281.5685921579;86593.13406865977;1116.5143162724241;1129.5030186717818;1135.846660700795;1161.8083016302385;1166.3701601135463;14714.264286785832;14875.396805558767;15532.301046453164;15988.68022639564;16245.268962896935;32213.35573288568;32638.673613263563;32662.673373265963;32905;34417.82791086029;41387.586124139576;42574.361384579875;42712.78643606886;43372.34941475817;46837.29744053774;9481.241500679791;9527.666531671359;9710.805783884423;9815.791446924384;9831.115199631782;11539.423028848692;11577.710557236136;11745.941270293593;11902.583409580624;14139.36372863203;13907.513237036655;14087.577372678836;14447.49433769813;14457.27713614336;15018.399264029316;13603.366805956724;14500.927495362455;14964.102153870366;15028;15180.392784288504;11030.779384412106;14157.646058848612;14244.64388390257;14707.632309192355;15621.921890390475;9447.622095116118;9552.283578731483;9580.616775328908;9615.5672994714;9622;13618.795718064435;13838.930805345908;14100.506482273071;14219.502317419254;14488.203148826915 08:43:15 INFO - 2015-12-17 08:43:15,644 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1511;1677.7399503077024;1725.585859393746;1734.4796561031692;1761.5155832146165;6350.841228969272;6755.695993680284;7113.893291600623;7136.785896423103;7140.964295178517;7013.89479157813;7166.64166791661;7176.712931482734;7178.784636460915;7183.748568800093;1939.3697048459308;1961.7057441383763;1962.7546556680416;2171.695962565238;2214.6345852934246;1935.8935258560773;2174.619441597722;2226.5769503794227;2231.3082944287244;2232.4530490029965;2155.1594877997595;2180.4439867833757;2182.050807898569;2211.756706762255;2213.6015517206897;2210.6462965925457;2212.3473575295325;2254.4476603232233;2256.4922892349255;2258.5708715344113;2219.744729356112;2240.5406891587186;2240.7199100112484;2240.843140980132;2244.6408574628144;7141.071660684078;7212.3148300911325;7219.819504512377;7220.711171553132;7226.566406015603;4308.138372325516;4370.322599997005;4396;4397.978010109961;4399.186150562156;2937.324415384452;2988.1633142720075;3048.9847550762106;3064.387122575494;3101.364220334826;1060.9893901060968;1079.13129930406;1079.438691880218;1114.0140975236893;1126.915481338903;9627.085426884434;9630.855537166948;9635.277354198393;9640.807183856283;9651.276154288385;3893.1045859452483;3927.19492504036;3954.62431069048;3960.34654282046;3978.9403158952637;8308.70919517814;8326;8330.541820199825;8332.33341332692;8343;4391.4730232371685;4391.758453285036;4415.580519850609;4420.182266280748;4420.381146639473;4013.7591744495426;4044.838206471767;4047.817848196838;4050.6151915567975;4052.7163098583405;3130.5617213590117;3166.762492813048;3349.3636209120677;3399.8300084995653;3436.9484457733156;1063.9202059845543;1093.491526440209;1093.7156339351825;1094.141099237095;1097.023648952433;1022.8925962773801;1060.9363438193734;1063.4257500949554;1196.1806162778526;1338;6722.865542689216;6742.393184613408;6778.898316525256;6787.762428315084;6793.45652347811;1083.544911137324;1087.8041952448634;1089.1178145702006;1090.7000574841982;1102.6581759654532;5363.168708850135;5402.6758394496455;5435.320584926884;5451.236826844245;5457.754401051962;8275.172482751677;8325.25072743456;8545.786355341166;8582.485050896841;8598.699045533376;8359.373047021498;8403.243708066304;8421.157884211652;8504.277136443348;8507.65969361231;6702.865942681119;6735.461163106939;6749.730010799612;6764.3573860483175;6771.729130834711;6527.869442611216;6537.673116344259;6540.149780528501;6580.341965803382;6600.669966501751;7420.703171873065;7463.253674632493;7604.8479030420185;7646.120696120018;7741.612919354123;7503.174650788518;7585.16563178061;7654.73208437702;7825.530468171928;7896.289333959971;6542.967285163734;6609.834754131185;6613.801585952429;6617.305182955721;6619.503537234823;6150.907736383869;6416.807495775134;6575.572587781779;6926.896096558455;7057.752978645723;6469.708863101266;6543.247526534509;6626.966865165643;6645.60126392418;6669.83325416849;6426.42162205385;6473.061406095995;6515.315891831479;6523.67381630907;6533.509986750918;6448.387403196689;6595.076689263411;6602.636854973022;6603.867922641424;6610.140681711347;6113.23584551931;6146.446819786241;6151.692415379123;6163.938360616516;6164.630122192682;5954.702264886651;6155.230596175478;6157.692115394302;6168.506519478521;6197.845053873689 08:43:15 INFO - 2015-12-17 08:43:15,645 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.53471906690163;336.5254990463447;338.1816005267253;339.56874769043316;342.3409935873444;6022.548308876835;6034.728437220325;6066.636001839893;6081.54388420868;6084.604500707451;5747.59766816323;5842.357340692521;5891.175235467038;6002.459778619924;6004.8498787530225;4640.953590464086;4661.324108004337;4669.649776266793;4675.976620116903;4678.157931572316;4423.734575925439;4664.813407463715;4666.696664716783;4675.485696573374;4680.625549956012;4462.062966776981;4516.051629157881;4596.03483268514;4615.653825963066;4625.722456652612;4582.473015603198;4582.702124361906;4583.564561366665;4598.287265473857;4608.078384323132;4052.8854564994567;4059.3707975263883;4059.7158198926086;4064.1871625674985;4066.1664358806374;5616.438356164392;5726.198332233491;5731.570132240098;5744.856378590527;5750.539956803487;5338.119210330291;5349;5349.545288650469;5350.170723537858;5353.250544923714;6386.42522173002;6406.775762848324;6413.134226879358;6414.230292364946;6414.871702565969;4447.688661793676;4448.933266001012;4456.420665313521;4462.531434199427;4463.4866990296205;6455.096286519891;6529.673516324165;6609.339066093448;6610.471162307004;6612.93387066128;4535;4535;4535;4537.342085397599;4545.295479200663;4580.862574122782;4592.357070010201;4593.747343896118;4609.1703493371515;4610.377599024089;5305.389880163831;5330.520253177233;5334.946650533445;5335.733213339395;5346.625736198429;6277.717502712298;6440.969444888889;6453.774117905851;6455.7417703292285;6458.61248325102;1625.3823547052045;1643.7041332560016;1644.7861777968787;1646.1275523972313;1646.6459711162158;1087.2715280761909;1088.0479580367178;1088.1784252889177;1095.05277934586;1109.2346281066039;6214;6225.159603453476;6226.906596401058;6228.190335256388;6228.56400051992;6479.319671434526;6645.269020407752;6650.501212409089;6651.86696266072;6653.201615806038;6139.293981192131;6197.845053873599;6269.592476489013;6272.09054687077;6285.308616052231;3597.892063238107;3624.873129440457;3648;3648.051506608248;3648.7628304160144;6648.7340506379205;6753.29090445506;6824.283450237753;6842.7683017056415;6846.246912839583;6841.828954276183;6852.554583952027;6853.520253582202;6853.7943861684225;6858.828529286708;6784.457243420515;6795.2185498667295;6827.0783444235385;6832.350926661859;6845.349691779273;6527.184101987252;6676.632785196861;6691.665416729047;6702.7654032110595;6708.060871478095;6622.966885165543;6632.375068108345;6637.037629543785;6638.070670106093;6662.533622646368;6805.251422343637;6811.761588344582;6826.863462730618;6829.248782634006;6849.315068493111;4510.255807791677;4527.90944181108;4534.59188673021;4539.046800171869;4544.636429085599;6570.638614876228;6711;6729.932700672931;6740.831479213059;6744;6502.837429064311;6515.511336649865;6521.445677117498;6522.119513865758;6528.575642583217;6340.1440805490665;6514.315996820265;6517.055027021151;6524.739010439529;6529;6383.521235907233;6385;6385.457236134795;6389.904151437825;6396.93603063982;6494.935050649433;6502.772402965874;6515.73937042513;6535.183102112236;6544.5418820684;6243.937560624518;6377.521685873671;6383.6808159592765;6390.488760899024;6390.48876089921 08:43:15 INFO - 2015-12-17 08:43:15,646 DEBUG : BROWSER_OUTPUT: |5;yui.html;852.62484506817;871.1549796697202;877.9868301975472;878.6134100995562;878.7232021913101;13454.125481843686;13800.861991380083;13814.79277810831;13838.792418113737;13869.653258668539;13381.93309033456;13456.461741530327;13471.461141554326;13475.191488510696;13494.527691530799;791.501354146888;804.6660635836121;805.2390490986021;805.6092794994423;805.697863301262;657.6711644177911;659.106910136765;797.4497596658316;799.348530947279;806.435495153392;833.154348336436;847.3856454070811;848.4909054567272;849.163573879728;850.4769566716456;841.7895526118471;844.2106630300689;844.3751623798375;844.5059640110481;850.6087199888059;506.39485814451746;507.0745888753041;612.1735656863243;616.5684021185143;618.4681174190193;13059.869401306056;13109.60671179866;13124.934375328157;13142.73714525704;13143.671408214776;11263.662090137226;12193.268403895794;12379.938100309531;12393.752124957451;12582.119251652388;10694.197935154816;10768.3538987661;10829.350238985608;10847.945760271226;10975.725606859813;3597.5503062117236;3620.1854582718943;3625.2024554597947;3654.543182102237;3696.9815150924073;45391;45572.088558228985;45579.77210113961;45791.54208457906;46712.53287467116;10162.39025658463;10217.284790064772;10259.19703262025;10310.896891030994;10322.741931451623;18582.349617763583;18621;18640.34758783436;18646.53383665419;18649;7415.036045314075;7477.364424024019;7503.09962804467;7565.6973721051645;7702.96148519265;4251.766152861623;4261.403403523509;4290.442242508454;4293.0769884474985;4312.245357062501;3005.834679092627;3038.3619439917425;3059.602251707264;3061.724444799934;3062.846857657108;540.5621446628244;552.1882832236606;553.8620923236305;557.83543854563;564.4524810933389;509.8725318670332;547.9589030822705;620.9875802483925;635.5868685354465;719.9208087110413;8354.8329033419;8522.74431767048;8596.785080372916;8668.096187777166;8736.956315218384;472.7069217085429;667.2926697700453;712.5831388637602;725.6444342272249;745.1840234942729;3968.6825053995613;4064.251027269331;4183.958160418357;4405.757683327448;4555.202839503074;51461.48538514642;52577.7371113142;56396.154057689164;56506;56916.14625780617;47153.76423117931;47201;51002.74498627483;51256.23115653268;51324.23013654798;44867.30796152176;45591.54408455939;45797.77101114473;46379.76810115928;46444.7677761609;8760.561971901252;8831;8853.778655533406;8928.598213080557;9062.229710474683;34723.65276347204;35227.82386088053;35560.82219588885;35845.46231806577;35886.28227435384;41042.38436423396;45308.32037519374;45397.77301113605;45591.77204113958;46112.53887461082;11029.61396351124;11035.39305338214;11147.219694621299;11344;11490.482928268415;12741.235525868478;12878;12943.352832358532;12989.48042078344;13057.08600398001;11684.298942063504;11748.118891083031;11792.23350482216;12056.75886482248;12144.878551214728;11934.462949167482;11981.400929953294;12162.498878733972;12243.32661703615;12601;11372.147088968195;11377.146713996648;11407.657770266906;11464.31214127155;11670.649880503599;10009.299349045497;10082.193424526167;10107.241956853119;10394.272400931863;10642.680719578426;8966.910330896608;9275.2579793615;10071.992800719869;10174.745631359276;10185.541650625592 08:43:15 INFO - 2015-12-17 08:43:15,646 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:43:15 INFO - 2015-12-17 08:43:15,646 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,899 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: __startTimestamp1450370595637__endTimestamp 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,647 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5313.20 Median:5496.78 stddev:582.71 (10.6%) stddev-sans-first:558.89 08:43:15 INFO - 2015-12-17 08:43:15,648 DEBUG : BROWSER_OUTPUT: Values: 3135.4 3203.7 3245.1 3252.8 3255.2 5154.7 5250.8 5303.9 5365.9 5426.1 5235.3 5261.8 5307.8 5393.2 5402.2 4825.5 4842.0 4851.9 4856.4 4884.1 4934.9 4965.4 4975.6 5034.5 5039.8 4669.1 4758.3 4812.5 4819.1 4823.9 4803.6 4821.1 4829.2 4847.8 4850.9 4789.3 4801.8 4804.8 4817.6 4818.6 5059.5 5114.1 5159.2 5249.4 5262.5 5734.2 5738.8 5759.5 5761.3 5764.7 5552.5 5779.6 5784.2 5796.3 5799.2 5203.7 5279.4 5280.4 5283.6 5317.5 5819.3 5826.4 5828.4 5858.5 5864.1 5643.8 5647.2 5653.1 5654.2 5699.0 5384.2 5544.4 5550.3 5569.6 5725.5 5715.1 5731.7 5756.6 5770.8 5776.5 5785.5 5796.4 5800.6 5801.3 5802.5 4357.6 4439.9 4444.0 4448.6 4458.3 3922.6 3943.3 3963.9 3979.2 3992.9 5395.3 5420.4 5427.0 5433.0 5435.3 5440.4 5480.2 5540.8 5658.5 5715.7 5492.2 5496.8 5511.3 5514.4 5529.5 5032.7 5044.3 5058.4 5069.9 5112.1 5742.8 5830.2 5862.8 5863.7 5940.9 5748.1 5752.0 5753.0 5771.7 5827.6 5843.0 5844.5 5845.8 5852.9 5869.1 5487.2 5580.9 5619.4 5663.4 5663.8 5707.7 5767.5 5810.2 5812.2 5830.6 5656.1 5673.1 5677.9 5680.6 5691.6 5340.3 5425.6 5445.3 5453.4 5642.4 5559.7 5576.4 5579.6 5584.9 5588.4 5681.2 5682.7 5686.6 5690.9 5730.0 5302.7 5473.2 5491.1 5566.3 5592.6 08:43:15 INFO - 2015-12-17 08:43:15,648 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,648 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42662.97 Median:32460.16 stddev:66988.92 (206.4%) stddev-sans-first:67102.23 08:43:15 INFO - 2015-12-17 08:43:15,649 DEBUG : BROWSER_OUTPUT: Values: 554.7 583.5 593.3 598.6 629.0 30025.8 30683.7 30702.4 30722.0 30736.4 40111.0 40593.0 40612.4 40647.2 40714.4 8878.9 9037.5 9041.2 9041.6 9048.8 7743.7 7915.1 8782.0 8895.3 10631.6 10590.0 10667.6 10688.2 10694.1 10701.7 10638.1 10739.9 10743.2 10746.7 10759.9 7639.4 7862.3 10607.6 10857.1 10868.3 39490.6 39830.6 39848.6 39901.2 39917.8 3380.7 3403.7 3426.0 3649.9 4037.3 30175.7 30455.8 30538.2 30619.0 31396.0 3978.8 3986.1 4028.8 4067.9 4075.5 250214.0 250710.0 250995.0 252586.0 253260.7 53647.7 54601.0 59295.0 59759.4 64578.0 57853.7 57856.7 58115.7 58120.7 58311.4 13770.3 13848.2 13898.7 13912.3 13931.3 10153.2 10158.7 10169.7 10214.2 10230.3 19217.0 19257.2 19334.4 19425.9 19519.9 7200.6 7344.9 7365.2 7472.4 7481.7 896.9 947.5 958.1 975.3 996.7 28725.6 28753.7 28913.7 28955.7 29315.9 1028.2 1033.1 1077.1 1104.3 1129.6 14714.7 14963.5 15011.5 15144.8 15151.5 304712.0 306402.0 307757.0 308541.0 308844.0 51585.7 51768.0 51855.0 51891.5 52057.2 1292.9 1294.5 1307.0 1309.1 1311.2 27342.3 28321.3 28815.4 28893.7 29029.0 43983.8 44610.6 46376.0 50098.0 50902.0 200162.0 200968.0 201177.0 201836.0 201875.0 27997.0 28101.3 28199.7 28258.6 28271.6 31384.7 33524.3 37279.7 40780.0 41080.0 34385.1 36952.6 37150.6 37477.8 37909.2 37273.8 37983.4 38187.2 38251.4 38275.2 35919.5 36381.5 36815.0 36989.0 37055.3 31100.5 33848.7 34240.7 34400.8 34416.5 25031.2 25281.9 25414.4 25427.7 25826.2 08:43:15 INFO - 2015-12-17 08:43:15,649 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,649 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27076.50 Median:354.82 stddev:79831.06 (22499.1%) stddev-sans-first:80029.79 08:43:15 INFO - 2015-12-17 08:43:15,649 DEBUG : BROWSER_OUTPUT: Values: 349.7 353.9 355.7 356.3 357.1 13705.2 13992.3 16482.5 16512.0 16899.0 14035.8 14181.3 14863.9 14892.7 14948.5 5262.4 5263.7 5399.9 5411.4 5415.6 3930.9 4042.8 5324.7 5784.0 5971.2 5854.7 5891.2 5899.6 5922.6 5931.1 5757.2 5880.3 5888.9 5890.2 5897.5 5172.7 5186.8 5191.4 5198.6 5210.9 12271.6 12534.7 12588.4 12590.6 19099.1 2079.7 2148.6 2173.8 2175.9 2177.6 9337.7 9382.9 9523.7 9538.0 12393.3 1851.7 1856.3 1860.8 1900.5 1900.8 57611.7 62603.4 63009.4 63951.0 64486.0 10192.7 10287.2 10384.7 10392.9 10432.4 13507.6 13578.1 13639.7 13650.4 13664.3 7094.3 7108.9 7125.9 7144.4 7190.9 6636.3 6699.8 6751.8 6765.5 6796.6 4389.1 4431.6 4461.2 4467.2 4503.6 1669.5 1717.8 1761.6 1767.5 1840.6 835.3 911.1 945.5 971.8 995.5 16504.9 16829.3 17102.7 17312.1 17471.9 942.2 944.9 952.9 962.0 970.7 9640.8 9729.8 10035.4 10055.7 10178.6 479140.0 480371.0 481122.0 493954.0 500552.0 84028.6 84969.6 85396.0 86281.6 86593.1 1116.5 1129.5 1135.8 1161.8 1166.4 14714.3 14875.4 15532.3 15988.7 16245.3 32213.4 32638.7 32662.7 32905.0 34417.8 41387.6 42574.4 42712.8 43372.3 46837.3 9481.2 9527.7 9710.8 9815.8 9831.1 11539.4 11577.7 11745.9 11902.6 14139.4 13907.5 14087.6 14447.5 14457.3 15018.4 13603.4 14500.9 14964.1 15028.0 15180.4 11030.8 14157.6 14244.6 14707.6 15621.9 9447.6 9552.3 9580.6 9615.6 9622.0 13618.8 13838.9 14100.5 14219.5 14488.2 08:43:15 INFO - 2015-12-17 08:43:15,650 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,650 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5058.04 Median:6156.46 stddev:2527.42 (41.1%) stddev-sans-first:2520.45 08:43:15 INFO - 2015-12-17 08:43:15,650 DEBUG : BROWSER_OUTPUT: Values: 1511.0 1677.7 1725.6 1734.5 1761.5 6350.8 6755.7 7113.9 7136.8 7141.0 7013.9 7166.6 7176.7 7178.8 7183.7 1939.4 1961.7 1962.8 2171.7 2214.6 1935.9 2174.6 2226.6 2231.3 2232.5 2155.2 2180.4 2182.1 2211.8 2213.6 2210.6 2212.3 2254.4 2256.5 2258.6 2219.7 2240.5 2240.7 2240.8 2244.6 7141.1 7212.3 7219.8 7220.7 7226.6 4308.1 4370.3 4396.0 4398.0 4399.2 2937.3 2988.2 3049.0 3064.4 3101.4 1061.0 1079.1 1079.4 1114.0 1126.9 9627.1 9630.9 9635.3 9640.8 9651.3 3893.1 3927.2 3954.6 3960.3 3978.9 8308.7 8326.0 8330.5 8332.3 8343.0 4391.5 4391.8 4415.6 4420.2 4420.4 4013.8 4044.8 4047.8 4050.6 4052.7 3130.6 3166.8 3349.4 3399.8 3436.9 1063.9 1093.5 1093.7 1094.1 1097.0 1022.9 1060.9 1063.4 1196.2 1338.0 6722.9 6742.4 6778.9 6787.8 6793.5 1083.5 1087.8 1089.1 1090.7 1102.7 5363.2 5402.7 5435.3 5451.2 5457.8 8275.2 8325.3 8545.8 8582.5 8598.7 8359.4 8403.2 8421.2 8504.3 8507.7 6702.9 6735.5 6749.7 6764.4 6771.7 6527.9 6537.7 6540.1 6580.3 6600.7 7420.7 7463.3 7604.8 7646.1 7741.6 7503.2 7585.2 7654.7 7825.5 7896.3 6543.0 6609.8 6613.8 6617.3 6619.5 6150.9 6416.8 6575.6 6926.9 7057.8 6469.7 6543.2 6627.0 6645.6 6669.8 6426.4 6473.1 6515.3 6523.7 6533.5 6448.4 6595.1 6602.6 6603.9 6610.1 6113.2 6146.4 6151.7 6163.9 6164.6 5954.7 6155.2 6157.7 6168.5 6197.8 08:43:15 INFO - 2015-12-17 08:43:15,650 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,651 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5380.08 Median:6168.57 stddev:1622.86 (26.3%) stddev-sans-first:1582.59 08:43:15 INFO - 2015-12-17 08:43:15,651 DEBUG : BROWSER_OUTPUT: Values: 333.5 336.5 338.2 339.6 342.3 6022.5 6034.7 6066.6 6081.5 6084.6 5747.6 5842.4 5891.2 6002.5 6004.8 4641.0 4661.3 4669.6 4676.0 4678.2 4423.7 4664.8 4666.7 4675.5 4680.6 4462.1 4516.1 4596.0 4615.7 4625.7 4582.5 4582.7 4583.6 4598.3 4608.1 4052.9 4059.4 4059.7 4064.2 4066.2 5616.4 5726.2 5731.6 5744.9 5750.5 5338.1 5349.0 5349.5 5350.2 5353.3 6386.4 6406.8 6413.1 6414.2 6414.9 4447.7 4448.9 4456.4 4462.5 4463.5 6455.1 6529.7 6609.3 6610.5 6612.9 4535.0 4535.0 4535.0 4537.3 4545.3 4580.9 4592.4 4593.7 4609.2 4610.4 5305.4 5330.5 5334.9 5335.7 5346.6 6277.7 6441.0 6453.8 6455.7 6458.6 1625.4 1643.7 1644.8 1646.1 1646.6 1087.3 1088.0 1088.2 1095.1 1109.2 6214.0 6225.2 6226.9 6228.2 6228.6 6479.3 6645.3 6650.5 6651.9 6653.2 6139.3 6197.8 6269.6 6272.1 6285.3 3597.9 3624.9 3648.0 3648.1 3648.8 6648.7 6753.3 6824.3 6842.8 6846.2 6841.8 6852.6 6853.5 6853.8 6858.8 6784.5 6795.2 6827.1 6832.4 6845.3 6527.2 6676.6 6691.7 6702.8 6708.1 6623.0 6632.4 6637.0 6638.1 6662.5 6805.3 6811.8 6826.9 6829.2 6849.3 4510.3 4527.9 4534.6 4539.0 4544.6 6570.6 6711.0 6729.9 6740.8 6744.0 6502.8 6515.5 6521.4 6522.1 6528.6 6340.1 6514.3 6517.1 6524.7 6529.0 6383.5 6385.0 6385.5 6389.9 6396.9 6494.9 6502.8 6515.7 6535.2 6544.5 6243.9 6377.5 6383.7 6390.5 6390.5 08:43:15 INFO - 2015-12-17 08:43:15,651 DEBUG : BROWSER_OUTPUT: 08:43:15 INFO - 2015-12-17 08:43:15,651 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13740.71 Median:4302.66 stddev:15474.96 (359.7%) stddev-sans-first:15488.10 08:43:15 INFO - 2015-12-17 08:43:15,652 DEBUG : BROWSER_OUTPUT: Values: 852.6 871.2 878.0 878.6 878.7 13454.1 13800.9 13814.8 13838.8 13869.7 13381.9 13456.5 13471.5 13475.2 13494.5 791.5 804.7 805.2 805.6 805.7 657.7 659.1 797.4 799.3 806.4 833.2 847.4 848.5 849.2 850.5 841.8 844.2 844.4 844.5 850.6 506.4 507.1 612.2 616.6 618.5 13059.9 13109.6 13124.9 13142.7 13143.7 11263.7 12193.3 12379.9 12393.8 12582.1 10694.2 10768.4 10829.4 10847.9 10975.7 3597.6 3620.2 3625.2 3654.5 3697.0 45391.0 45572.1 45579.8 45791.5 46712.5 10162.4 10217.3 10259.2 10310.9 10322.7 18582.3 18621.0 18640.3 18646.5 18649.0 7415.0 7477.4 7503.1 7565.7 7703.0 4251.8 4261.4 4290.4 4293.1 4312.2 3005.8 3038.4 3059.6 3061.7 3062.8 540.6 552.2 553.9 557.8 564.5 509.9 548.0 621.0 635.6 719.9 8354.8 8522.7 8596.8 8668.1 8737.0 472.7 667.3 712.6 725.6 745.2 3968.7 4064.3 4184.0 4405.8 4555.2 51461.5 52577.7 56396.2 56506.0 56916.1 47153.8 47201.0 51002.7 51256.2 51324.2 44867.3 45591.5 45797.8 46379.8 46444.8 8760.6 8831.0 8853.8 8928.6 9062.2 34723.7 35227.8 35560.8 35845.5 35886.3 41042.4 45308.3 45397.8 45591.8 46112.5 11029.6 11035.4 11147.2 11344.0 11490.5 12741.2 12878.0 12943.4 12989.5 13057.1 11684.3 11748.1 11792.2 12056.8 12144.9 11934.5 11981.4 12162.5 12243.3 12601.0 11372.1 11377.1 11407.7 11464.3 11670.6 10009.3 10082.2 10107.2 10394.3 10642.7 8966.9 9275.3 10072.0 10174.7 10185.5 08:43:15 INFO - 2015-12-17 08:43:15,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:43:15 INFO - 2015-12-17 08:43:15,652 DEBUG : BROWSER_OUTPUT: 08:43:16 INFO - 2015-12-17 08:43:16,372 INFO : Browser exited with error code: 0 08:43:16 INFO - 2015-12-17 08:43:16,386 INFO : Completed test dromaeo_css (00:18:33) 08:43:16 INFO - 2015-12-17 08:43:16,386 INFO : Starting test kraken 08:43:16 INFO - 2015-12-17 08:43:16,386 DEBUG : operating with platform_type : linux_ 08:43:16 INFO - 2015-12-17 08:43:16,386 INFO : Initialising browser for kraken test... 08:43:16 INFO - 2015-12-17 08:43:16,392 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHHAqg1/profile http://localhost:54295/getInfo.html 08:43:20 INFO - 2015-12-17 08:43:20,076 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:43:20 INFO - 2015-12-17 08:43:20,076 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:43:20 INFO - 2015-12-17 08:43:20,076 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:43:20 INFO - 2015-12-17 08:43:20,076 DEBUG : BROWSER_OUTPUT: __metrics 08:43:20 INFO - 2015-12-17 08:43:20,140 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:43:20 INFO - 2015-12-17 08:43:20,196 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:21 INFO - 2015-12-17 08:43:21,313 INFO : Browser initialized. 08:43:21 INFO - 2015-12-17 08:43:21,314 INFO : Running cycle 1/1 for kraken test... 08:43:21 INFO - 2015-12-17 08:43:21,314 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHHAqg1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:43:33 INFO - 2015-12-17 08:43:33,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 150040576 08:43:33 INFO - 2015-12-17 08:43:33,116 DEBUG : BROWSER_OUTPUT: 08:43:35 INFO - 2015-12-17 08:43:35,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54295/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:36 INFO - 2015-12-17 08:43:36,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 185368576 08:43:36 INFO - 2015-12-17 08:43:36,193 DEBUG : BROWSER_OUTPUT: 08:43:38 INFO - 2015-12-17 08:43:38,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54295/tests/kraken/driver.html?testName=audio-dft) 08:43:39 INFO - 2015-12-17 08:43:39,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 175599616 08:43:39 INFO - 2015-12-17 08:43:39,418 DEBUG : BROWSER_OUTPUT: 08:43:42 INFO - 2015-12-17 08:43:42,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54295/tests/kraken/driver.html?testName=audio-fft) 08:43:42 INFO - 2015-12-17 08:43:42,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 160538624 08:43:42 INFO - 2015-12-17 08:43:42,874 DEBUG : BROWSER_OUTPUT: 08:43:44 INFO - 2015-12-17 08:43:44,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54295/tests/kraken/driver.html?testName=audio-oscillator) 08:43:45 INFO - 2015-12-17 08:43:45,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 164446208 08:43:45 INFO - 2015-12-17 08:43:45,432 DEBUG : BROWSER_OUTPUT: 08:43:47 INFO - 2015-12-17 08:43:47,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:48 INFO - 2015-12-17 08:43:48,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 163622912 08:43:48 INFO - 2015-12-17 08:43:48,214 DEBUG : BROWSER_OUTPUT: 08:43:51 INFO - 2015-12-17 08:43:51,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54295/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:51 INFO - 2015-12-17 08:43:51,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 165707776 08:43:51 INFO - 2015-12-17 08:43:51,667 DEBUG : BROWSER_OUTPUT: 08:43:55 INFO - 2015-12-17 08:43:55,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54295/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:55 INFO - 2015-12-17 08:43:55,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 166592512 08:43:55 INFO - 2015-12-17 08:43:55,595 DEBUG : BROWSER_OUTPUT: 08:43:58 INFO - 2015-12-17 08:43:58,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54295/tests/kraken/driver.html?testName=json-parse-financial) 08:43:58 INFO - 2015-12-17 08:43:58,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 165429248 08:43:58 INFO - 2015-12-17 08:43:58,871 DEBUG : BROWSER_OUTPUT: 08:44:00 INFO - 2015-12-17 08:44:00,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:01 INFO - 2015-12-17 08:44:01,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 176922624 08:44:01 INFO - 2015-12-17 08:44:01,019 DEBUG : BROWSER_OUTPUT: 08:44:02 INFO - 2015-12-17 08:44:02,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:03 INFO - 2015-12-17 08:44:03,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 174272512 08:44:03 INFO - 2015-12-17 08:44:03,441 DEBUG : BROWSER_OUTPUT: 08:44:05 INFO - 2015-12-17 08:44:05,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:06 INFO - 2015-12-17 08:44:06,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 184078336 08:44:06 INFO - 2015-12-17 08:44:06,074 DEBUG : BROWSER_OUTPUT: 08:44:08 INFO - 2015-12-17 08:44:08,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:09 INFO - 2015-12-17 08:44:09,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 191504384 08:44:09 INFO - 2015-12-17 08:44:09,052 DEBUG : BROWSER_OUTPUT: 08:44:11 INFO - 2015-12-17 08:44:11,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:12 INFO - 2015-12-17 08:44:12,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 188649472 08:44:12 INFO - 2015-12-17 08:44:12,209 DEBUG : BROWSER_OUTPUT: 08:44:13 INFO - 2015-12-17 08:44:13,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54295/tests/kraken/driver.html?testName=ai-astar) 08:44:14 INFO - 2015-12-17 08:44:14,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 248270848 08:44:14 INFO - 2015-12-17 08:44:14,122 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,125 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:44:14 INFO - 2015-12-17 08:44:14,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:44:14 INFO - 2015-12-17 08:44:14,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;106;110;111;112;101;111;111;111 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;124;152;167;140;148;150;123;165;124 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;162;162;161;159;160;160;162 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;76;95;71;77;70;101;93;72 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;145;93;93;93;139;95;94;146 08:44:14 INFO - 2015-12-17 08:44:14,126 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;109 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;146;146;145;145;145 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;95;95;96;96;96 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;56;57;57;58;57;67;55;55 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;74;70;68;68;68;68 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;85;84;85;84;91;84;84;85 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;117;117;111;121;129;123;114;118;121 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;156;156;150;141;145;144;155;150;140 08:44:14 INFO - 2015-12-17 08:44:14,127 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;66;68;69;67;70;67;67 08:44:14 INFO - 2015-12-17 08:44:14,128 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:44:14 INFO - 2015-12-17 08:44:14,128 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:44:14 INFO - 2015-12-17 08:44:14,128 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 08:44:14 INFO - 2015-12-17 08:44:14,128 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:44:14 INFO - 2015-12-17 08:44:14,128 DEBUG : BROWSER_OUTPUT: __startTimestamp1450370654123__endTimestamp 08:44:14 INFO - 2015-12-17 08:44:14,128 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,132 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:44:14 INFO - 2015-12-17 08:44:14,132 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:44:14 INFO - 2015-12-17 08:44:14,132 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,132 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.44 (3.1%) stddev-sans-first:3.64 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 106.0 110.0 111.0 112.0 101.0 111.0 111.0 111.0 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.00 stddev:16.46 (10.9%) stddev-sans-first:17.11 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: Values: 154.0 124.0 152.0 167.0 140.0 148.0 150.0 123.0 165.0 124.0 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 162.0 162.0 161.0 159.0 160.0 160.0 162.0 08:44:14 INFO - 2015-12-17 08:44:14,133 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:74.00 stddev:11.86 (16.0%) stddev-sans-first:12.16 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 76.0 95.0 71.0 77.0 70.0 101.0 93.0 72.0 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:24.11 (25.9%) stddev-sans-first:25.00 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 145.0 93.0 93.0 93.0 139.0 95.0 94.0 146.0 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 08:44:14 INFO - 2015-12-17 08:44:14,134 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.50 stddev:3.51 (6.1%) stddev-sans-first:3.71 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 56.0 57.0 57.0 58.0 57.0 67.0 55.0 55.0 08:44:14 INFO - 2015-12-17 08:44:14,135 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:2.00 (2.9%) stddev-sans-first:2.03 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 74.0 70.0 68.0 68.0 68.0 68.0 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.16 (2.6%) stddev-sans-first:2.26 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 84.0 85.0 84.0 91.0 84.0 84.0 85.0 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:119.50 stddev:4.98 (4.2%) stddev-sans-first:5.27 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: Values: 118.0 117.0 117.0 111.0 121.0 129.0 123.0 114.0 118.0 121.0 08:44:14 INFO - 2015-12-17 08:44:14,136 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.00 stddev:6.69 (4.5%) stddev-sans-first:6.33 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: Values: 139.0 156.0 156.0 150.0 141.0 145.0 144.0 155.0 150.0 140.0 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 66.0 68.0 69.0 67.0 70.0 67.0 67.0 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:44:14 INFO - 2015-12-17 08:44:14,137 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-12-17 08:44:14,969 INFO : Browser exited with error code: 0 08:44:15 INFO - 2015-12-17 08:44:15,022 INFO : Completed test kraken (00:00:58) 08:44:15 INFO - 2015-12-17 08:44:15,022 INFO : Starting test v8_7 08:44:15 INFO - 2015-12-17 08:44:15,022 DEBUG : operating with platform_type : linux_ 08:44:15 INFO - 2015-12-17 08:44:15,022 INFO : Initialising browser for v8_7 test... 08:44:15 INFO - 2015-12-17 08:44:15,029 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWfABAu/profile http://localhost:54295/getInfo.html 08:44:18 INFO - 2015-12-17 08:44:18,844 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:44:18 INFO - 2015-12-17 08:44:18,844 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:44:18 INFO - 2015-12-17 08:44:18,844 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:44:18 INFO - 2015-12-17 08:44:18,844 DEBUG : BROWSER_OUTPUT: __metrics 08:44:18 INFO - 2015-12-17 08:44:18,920 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:44:18 INFO - 2015-12-17 08:44:18,968 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:20 INFO - 2015-12-17 08:44:20,147 INFO : Browser initialized. 08:44:20 INFO - 2015-12-17 08:44:20,147 INFO : Running cycle 1/1 for v8_7 test... 08:44:20 INFO - 2015-12-17 08:44:20,148 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWfABAu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:44:31 INFO - 2015-12-17 08:44:31,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 149766144 08:44:31 INFO - 2015-12-17 08:44:31,866 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54295/tests/v8_7/run.html (next: http://localhost:54295/tests/v8_7/run.html) 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 619995136 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:44:53 INFO - 2015-12-17 08:44:53,521 DEBUG : BROWSER_OUTPUT: |0;Richards;167.78523489932886 08:44:53 INFO - 2015-12-17 08:44:53,522 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.9699248120301 08:44:53 INFO - 2015-12-17 08:44:53,522 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 08:44:53 INFO - 2015-12-17 08:44:53,522 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 08:44:53 INFO - 2015-12-17 08:44:53,522 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1140.2508551881415 08:44:53 INFO - 2015-12-17 08:44:53,522 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 08:44:53 INFO - 2015-12-17 08:44:53,523 DEBUG : BROWSER_OUTPUT: |6;Boyer;11674.418604651162 08:44:53 INFO - 2015-12-17 08:44:53,523 DEBUG : BROWSER_OUTPUT: |7;RegExp;25100 08:44:53 INFO - 2015-12-17 08:44:53,523 DEBUG : BROWSER_OUTPUT: |8;Splay;698.0609418282548 08:44:53 INFO - 2015-12-17 08:44:53,523 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 08:44:53 INFO - 2015-12-17 08:44:53,523 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:44:53 INFO - 2015-12-17 08:44:53,523 DEBUG : BROWSER_OUTPUT: __startTimestamp1450370693519__endTimestamp 08:44:53 INFO - 2015-12-17 08:44:53,524 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,524 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:44:53 INFO - 2015-12-17 08:44:53,524 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:44:53 INFO - 2015-12-17 08:44:53,524 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,524 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,524 DEBUG : BROWSER_OUTPUT: Values: 167.8 08:44:53 INFO - 2015-12-17 08:44:53,525 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,525 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.97 Median:187.97 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,525 DEBUG : BROWSER_OUTPUT: Values: 188.0 08:44:53 INFO - 2015-12-17 08:44:53,525 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,525 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,526 DEBUG : BROWSER_OUTPUT: Values: 281.3 08:44:53 INFO - 2015-12-17 08:44:53,526 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,526 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,526 DEBUG : BROWSER_OUTPUT: Values: 5196.9 08:44:53 INFO - 2015-12-17 08:44:53,526 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,527 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1140.25 Median:1140.25 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,527 DEBUG : BROWSER_OUTPUT: Values: 1140.3 08:44:53 INFO - 2015-12-17 08:44:53,527 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,527 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,527 DEBUG : BROWSER_OUTPUT: Values: 784.9 08:44:53 INFO - 2015-12-17 08:44:53,528 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,528 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11674.42 Median:11674.42 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,528 DEBUG : BROWSER_OUTPUT: Values: 11674.4 08:44:53 INFO - 2015-12-17 08:44:53,528 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,528 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,528 DEBUG : BROWSER_OUTPUT: Values: 25100.0 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:698.06 Median:698.06 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: Values: 698.1 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: Values: 4864.1 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:44:53 INFO - 2015-12-17 08:44:53,529 DEBUG : BROWSER_OUTPUT: 08:44:54 INFO - 2015-12-17 08:44:54,325 INFO : Browser exited with error code: 0 08:44:54 INFO - 2015-12-17 08:44:54,344 INFO : Completed test v8_7 (00:00:39) 08:44:54 INFO - 2015-12-17 08:44:54,527 INFO : Completed test suite (00:20:11) 08:44:54 INFO - 2015-12-17 08:44:54,527 DEBUG : Working with test: dromaeo_css 08:44:54 INFO - 2015-12-17 08:44:54,527 DEBUG : Generating results file: dromaeo_css 08:44:54 INFO - 2015-12-17 08:44:54,528 DEBUG : Working with test: kraken 08:44:54 INFO - 2015-12-17 08:44:54,528 DEBUG : Generating results file: kraken 08:44:54 INFO - 2015-12-17 08:44:54,529 INFO : javascript benchmark 08:44:54 INFO - 2015-12-17 08:44:54,529 DEBUG : Working with test: v8_7 08:44:54 INFO - 2015-12-17 08:44:54,529 DEBUG : Generating results file: v8_7 08:44:54 INFO - 2015-12-17 08:44:54,529 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:44:54 INFO - 2015-12-17 08:44:54,599 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:44:54 INFO - 2015-12-17 08:44:54,599 DEBUG : process_Request line: dromaeo_css 6896.27 graph.html#tests=[[72,64,35]] 08:44:54 INFO - 2015-12-17 08:44:54,599 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:44:54 INFO - 2015-12-17 08:44:54,629 DEBUG : process_Request line: kraken 1499.10 graph.html#tests=[[232,64,35]] 08:44:54 INFO - 2015-12-17 08:44:54,630 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:44:54 INFO - 2015-12-17 08:44:54,667 DEBUG : process_Request line: v8_7 20801.26 graph.html#tests=[[230,64,35]] 08:44:54 INFO - 2015-12-17 08:44:54,668 INFO : javascript benchmark 08:44:54 INFO - 2015-12-17 08:44:54,672 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3135.435621588114, 3203.6636153203926, 3245.140037889958, 3252.8048317100975, 3255.2024753935284, 5154.74226288686, 5250.763715632796, 5303.89392212156, 5365.865853353668, 5426.077566813647, 5235.293235413227, 5261.815836445725, 5307.814226502073, 5393.1910213468, 5402.189671549269, 4825.469198388183, 4841.951580484203, 4851.878703032417, 4856.441509226431, 4884.072026314989, 4934.901301973959, 4965.42897566779, 4975.626827987898, 5034.521720436571, 5039.848804535852, 4669.136209801164, 4758.310045043467, 4812.470628230909, 4819.084373968934, 4823.927641085386, 4803.5916947059195, 4821.059893320804, 4829.154897892855, 4847.806087756486, 4850.902981940341, 4789.305550695164, 4801.783919723621, 4804.75976201192, 4817.56641902227, 4818.614510839159, 5059.519345662156, 5114.05390002847, 5159.22611608258, 5249.396319423277, 5262.500062494057, 5734.168545560912, 5738.8278351649515, 5759.452851979056, 5761.337446193699, 5764.682942438164, 5552.472515111058, 5779.595428320019, 5784.219130417382, 5796.333421656522, 5799.18811366409, 5203.713795741195, 5279.445658205871, 5280.392754833167, 5283.630145889828, 5317.521423071865, 5819.301683797971, 5826.388229235954, 5828.417158284137, 5858.53131749459, 5864.06175011996, 5643.830685079454, 5647.152927060892, 5653.123765816305, 5654.170958800518, 5698.971505142447, 5384.246205531229, 5544.445555444423, 5550.333959924835, 5569.635439317393, 5725.456081672234, 5715.114157305624, 5731.684757338303, 5756.597038207286, 5770.826875193751, 5776.480116789425, 5785.508231800344, 5796.42035796417, 5800.622959507618, 5801.274840644919, 5802.4777770000055, 4357.586029327209, 4439.889002774957, 4443.977885086383, 4448.5551444855255, 4458.308962110878, 3922.5685174630767, 3943.3493473577114, 3963.8612648557164, 3979.2041591681777, 3992.900177495586, 5395.325584301962, 5420.376656684532, 5427.0, 5433.0, 5435.266239057755, 5440.4287549807495, 5480.177973303957, 5540.833774986757, 5658.490735833712, 5715.714214289269, 5492.231087647732, 5496.780128794803, 5511.338639363302, 5514.448555144453, 5529.502344788988, 5032.672876263031, 5044.268581055726, 5058.418281897555, 5069.923951140736, 5112.054269960069, 5742.799002034909, 5830.2129212555765, 5862.765489380462, 5863.736131874076, 5940.910886336708, 5748.080307150836, 5751.97124014394, 5752.9712351437975, 5771.7114144293455, 5827.59206855516, 5843.0, 5844.532437405082, 5845.795397161079, 5852.912206316993, 5869.148973398748, 5487.2317875496665, 5580.888382232414, 5619.353774316006, 5663.433656634468, 5663.773449062156, 5707.714614269187, 5767.509761670305, 5810.244668193108, 5812.244408227072, 5830.562707797017, 5656.066748986371, 5673.149027645886, 5677.858053548694, 5680.630759000652, 5691.573132015033, 5340.252364668871, 5425.565954723534, 5445.319335083114, 5453.427390124139, 5642.379338272869, 5559.6664200148125, 5576.414476479911, 5579.581531385081, 5584.888302234014, 5588.3573389060775, 5681.17622944679, 5682.687452190004, 5686.60193786431, 5690.914636280542, 5730.025895597675, 5302.7083510405755, 5473.2063850742215, 5491.148871924858, 5566.276384070045, 5592.608517403743], "unit": "score", "name": "dojo.html", "value": 5275.96651568074}, {"lowerIsBetter": false, "replicates": [554.7133574781502, 583.5215123598649, 593.3117583603022, 598.6408155106939, 628.9748410063597, 30025.849870750644, 30683.69316306836, 30702.38595228094, 30722.0, 30736.38527229457, 40111.0, 40593.0, 40612.39081413781, 40647.18705625893, 40714.38928416076, 8878.911210887873, 9037.457752534836, 9041.186293233608, 9041.593128309241, 9048.77378065547, 7743.651535680908, 7915.050193976702, 8781.990071141836, 8895.28837692983, 10631.574737010511, 10590.0, 10667.573297068107, 10688.198385121146, 10694.144468442544, 10701.732456688605, 10638.095761860252, 10739.946300268448, 10743.19426043046, 10746.677599672023, 10759.892401076046, 7639.350655194316, 7862.2923936845955, 10607.575696972111, 10857.131429485702, 10868.347899126078, 39490.60509394898, 39830.60169398298, 39848.60151398507, 39901.20197596032, 39917.80041099805, 3380.6619338066, 3403.6936675699058, 3425.9657403425895, 3649.908752281188, 4037.2964550446213, 30175.69824301751, 30455.847720761256, 30538.236544086576, 30618.99589848881, 31396.0, 3978.8408463661417, 3986.142979259444, 4028.798560072014, 4067.8983025424304, 4075.49056367954, 250214.0, 250710.0, 250995.0, 252586.0, 253260.73369633217, 53647.73176134095, 54601.0, 59295.0, 59759.40240597539, 64578.0, 57853.71073144607, 57856.71071644699, 58115.70942145262, 58120.709396452745, 58311.416885831444, 13770.311484425738, 13848.16910985324, 13898.722025559635, 13912.304384780922, 13931.303434828218, 10153.187744980383, 10158.695239142837, 10169.694909152737, 10214.233932455096, 10230.28388012832, 19217.0, 19257.22971081141, 19334.419967401, 19425.902870485555, 19519.902400487907, 7200.639968001579, 7344.889826652605, 7365.226651201654, 7472.439567032494, 7481.663325150273, 896.9461832289953, 947.5357075033185, 958.1147158882299, 975.2929126383457, 996.6611352140308, 28725.56911646327, 28753.712462875104, 28913.710862891523, 28955.71044289572, 29315.85342073276, 1028.1620479309338, 1033.0805583031108, 1077.1113831089226, 1104.2601457023814, 1129.6102844518628, 14714.705705885823, 14963.476278330207, 15011.549653510412, 15144.848551514344, 15151.545453636409, 304712.0, 306402.0, 307757.0, 308541.0, 308844.0, 51585.7420712894, 51768.0, 51855.0, 51891.48108518942, 52057.21914171291, 1292.8642492538336, 1294.5469085819889, 1306.9542566010143, 1309.12942892977, 1311.2329287366806, 27342.316442089108, 28321.29196770015, 28815.42369152647, 28893.711062889102, 29029.0, 43983.78008109939, 44610.55389446194, 46376.0, 50098.0, 50902.0, 200162.0, 200968.0, 201177.0, 201836.0, 201875.0, 27997.0, 28101.297467563476, 28199.71800281971, 28258.576121357786, 28271.57592636071, 31384.744610215337, 33524.329513410084, 37279.677425793874, 40780.0, 41080.0, 34385.14037149091, 36952.63047369492, 37150.628493714714, 37477.81261093677, 37909.241815164096, 37273.81363093167, 37983.430248545745, 38187.2362552753, 38251.42622860603, 38275.23449531049, 35919.461208081375, 36381.51523924559, 36815.0, 36989.0, 37055.258894822495, 31100.533491998092, 33848.67124633935, 34240.65759342375, 34400.82799585986, 34416.483752743225, 25031.249062528153, 25281.87359063193, 25414.364640884127, 25427.709157772893, 25826.225213243633], "unit": "score", "name": "ext.html", "value": 18172.730196939006}, {"lowerIsBetter": false, "replicates": [349.6905238863605, 353.89206292080905, 355.74564186606574, 356.3087610036529, 357.10901301253375, 13705.177689338621, 13992.300384980761, 16482.505524834243, 16512.0, 16898.98606083636, 14035.78946315806, 14181.290935453238, 14863.851361486382, 14892.7021459571, 14948.476803311887, 5262.421133675292, 5263.710495922723, 5399.865003374927, 5411.431799661038, 5415.620906536544, 3930.862419815307, 4042.818073186699, 5324.7071411072375, 5783.9710801445935, 5971.223740913675, 5854.677992710421, 5891.175235467038, 5899.5870289079785, 5922.555808314372, 5931.051031834907, 5757.193992841006, 5880.294364676266, 5888.852778680546, 5890.204822348971, 5897.498712609433, 5172.663776854492, 5186.818461353834, 5191.377034755816, 5198.558122559587, 5210.947890521122, 12271.57049503263, 12534.74930501385, 12588.37058147089, 12590.622281331483, 19099.140538675794, 2079.656856618656, 2148.5917675641736, 2173.7608863025052, 2175.9020844062056, 2177.6298029335053, 9337.71986840396, 9382.85925711115, 9523.714288571355, 9538.0, 12393.256404615751, 1851.6666999940005, 1856.3131641292807, 1860.7953125156223, 1900.4678689966831, 1900.8194221548931, 57611.711941440444, 62603.37396626021, 63009.36990630081, 63951.0, 64486.0, 10192.745181370377, 10287.177025837915, 10384.688459346231, 10392.948035259775, 10432.374057556419, 13507.594772156852, 13578.117422367515, 13639.727205455836, 13650.385732642055, 13664.316784160752, 7094.290570942864, 7108.928910710827, 7125.92874071263, 7144.428445724329, 7190.892136617955, 6636.30318816527, 6699.832504187434, 6751.797446076625, 6765.492588055916, 6796.626185559743, 4389.122175564899, 4431.556844315543, 4461.219286624892, 4467.195904737178, 4503.617192538671, 1669.5074952888926, 1717.7938647362396, 1761.5508045448585, 1767.5404394857173, 1840.5950690847992, 835.2566216067704, 911.0616065452595, 945.4563625915126, 971.8493633486821, 995.5121990224737, 16504.917475412545, 16829.326826926786, 17102.743458848126, 17312.134393280285, 17471.912640436716, 942.236788201559, 944.9433034017981, 952.8856537215579, 962.0043255230803, 970.7476056225291, 9640.75898102553, 9729.756756081155, 10035.448050357301, 10055.69832905014, 10178.643747468803, 479140.0, 480371.0, 481122.0, 493954.0, 500552.0, 84028.57985710155, 84969.57515212384, 85396.0, 86281.5685921579, 86593.13406865977, 1116.5143162724241, 1129.5030186717818, 1135.846660700795, 1161.8083016302385, 1166.3701601135463, 14714.264286785832, 14875.396805558767, 15532.301046453164, 15988.68022639564, 16245.268962896935, 32213.35573288568, 32638.673613263563, 32662.673373265963, 32905.0, 34417.82791086029, 41387.586124139576, 42574.361384579875, 42712.78643606886, 43372.34941475817, 46837.29744053774, 9481.241500679791, 9527.666531671359, 9710.805783884423, 9815.791446924384, 9831.115199631782, 11539.423028848692, 11577.710557236136, 11745.941270293593, 11902.583409580624, 14139.36372863203, 13907.513237036655, 14087.577372678836, 14447.49433769813, 14457.27713614336, 15018.399264029316, 13603.366805956724, 14500.927495362455, 14964.102153870366, 15028.0, 15180.392784288504, 11030.779384412106, 14157.646058848612, 14244.64388390257, 14707.632309192355, 15621.921890390475, 9447.622095116118, 9552.283578731483, 9580.616775328908, 9615.5672994714, 9622.0, 13618.795718064435, 13838.930805345908, 14100.506482273071, 14219.502317419254, 14488.203148826915], "unit": "score", "name": "jquery.html", "value": 8643.357653796274}, {"lowerIsBetter": false, "replicates": [1511.0, 1677.7399503077024, 1725.585859393746, 1734.4796561031692, 1761.5155832146165, 6350.841228969272, 6755.695993680284, 7113.893291600623, 7136.785896423103, 7140.964295178517, 7013.89479157813, 7166.64166791661, 7176.712931482734, 7178.784636460915, 7183.748568800093, 1939.3697048459308, 1961.7057441383763, 1962.7546556680416, 2171.695962565238, 2214.6345852934246, 1935.8935258560773, 2174.619441597722, 2226.5769503794227, 2231.3082944287244, 2232.4530490029965, 2155.1594877997595, 2180.4439867833757, 2182.050807898569, 2211.756706762255, 2213.6015517206897, 2210.6462965925457, 2212.3473575295325, 2254.4476603232233, 2256.4922892349255, 2258.5708715344113, 2219.744729356112, 2240.5406891587186, 2240.7199100112484, 2240.843140980132, 2244.6408574628144, 7141.071660684078, 7212.3148300911325, 7219.819504512377, 7220.711171553132, 7226.566406015603, 4308.138372325516, 4370.322599997005, 4396.0, 4397.978010109961, 4399.186150562156, 2937.324415384452, 2988.1633142720075, 3048.9847550762106, 3064.387122575494, 3101.364220334826, 1060.9893901060968, 1079.13129930406, 1079.438691880218, 1114.0140975236893, 1126.915481338903, 9627.085426884434, 9630.855537166948, 9635.277354198393, 9640.807183856283, 9651.276154288385, 3893.1045859452483, 3927.19492504036, 3954.62431069048, 3960.34654282046, 3978.9403158952637, 8308.70919517814, 8326.0, 8330.541820199825, 8332.33341332692, 8343.0, 4391.4730232371685, 4391.758453285036, 4415.580519850609, 4420.182266280748, 4420.381146639473, 4013.7591744495426, 4044.838206471767, 4047.817848196838, 4050.6151915567975, 4052.7163098583405, 3130.5617213590117, 3166.762492813048, 3349.3636209120677, 3399.8300084995653, 3436.9484457733156, 1063.9202059845543, 1093.491526440209, 1093.7156339351825, 1094.141099237095, 1097.023648952433, 1022.8925962773801, 1060.9363438193734, 1063.4257500949554, 1196.1806162778526, 1338.0, 6722.865542689216, 6742.393184613408, 6778.898316525256, 6787.762428315084, 6793.45652347811, 1083.544911137324, 1087.8041952448634, 1089.1178145702006, 1090.7000574841982, 1102.6581759654532, 5363.168708850135, 5402.6758394496455, 5435.320584926884, 5451.236826844245, 5457.754401051962, 8275.172482751677, 8325.25072743456, 8545.786355341166, 8582.485050896841, 8598.699045533376, 8359.373047021498, 8403.243708066304, 8421.157884211652, 8504.277136443348, 8507.65969361231, 6702.865942681119, 6735.461163106939, 6749.730010799612, 6764.3573860483175, 6771.729130834711, 6527.869442611216, 6537.673116344259, 6540.149780528501, 6580.341965803382, 6600.669966501751, 7420.703171873065, 7463.253674632493, 7604.8479030420185, 7646.120696120018, 7741.612919354123, 7503.174650788518, 7585.16563178061, 7654.73208437702, 7825.530468171928, 7896.289333959971, 6542.967285163734, 6609.834754131185, 6613.801585952429, 6617.305182955721, 6619.503537234823, 6150.907736383869, 6416.807495775134, 6575.572587781779, 6926.896096558455, 7057.752978645723, 6469.708863101266, 6543.247526534509, 6626.966865165643, 6645.60126392418, 6669.83325416849, 6426.42162205385, 6473.061406095995, 6515.315891831479, 6523.67381630907, 6533.509986750918, 6448.387403196689, 6595.076689263411, 6602.636854973022, 6603.867922641424, 6610.140681711347, 6113.23584551931, 6146.446819786241, 6151.692415379123, 6163.938360616516, 6164.630122192682, 5954.702264886651, 6155.230596175478, 6157.692115394302, 6168.506519478521, 6197.845053873689], "unit": "score", "name": "mootools.html", "value": 4221.948713758929}, {"lowerIsBetter": false, "replicates": [333.53471906690163, 336.5254990463447, 338.1816005267253, 339.56874769043316, 342.3409935873444, 6022.548308876835, 6034.728437220325, 6066.636001839893, 6081.54388420868, 6084.604500707451, 5747.59766816323, 5842.357340692521, 5891.175235467038, 6002.459778619924, 6004.8498787530225, 4640.953590464086, 4661.324108004337, 4669.649776266793, 4675.976620116903, 4678.157931572316, 4423.734575925439, 4664.813407463715, 4666.696664716783, 4675.485696573374, 4680.625549956012, 4462.062966776981, 4516.051629157881, 4596.03483268514, 4615.653825963066, 4625.722456652612, 4582.473015603198, 4582.702124361906, 4583.564561366665, 4598.287265473857, 4608.078384323132, 4052.8854564994567, 4059.3707975263883, 4059.7158198926086, 4064.1871625674985, 4066.1664358806374, 5616.438356164392, 5726.198332233491, 5731.570132240098, 5744.856378590527, 5750.539956803487, 5338.119210330291, 5349.0, 5349.545288650469, 5350.170723537858, 5353.250544923714, 6386.42522173002, 6406.775762848324, 6413.134226879358, 6414.230292364946, 6414.871702565969, 4447.688661793676, 4448.933266001012, 4456.420665313521, 4462.531434199427, 4463.4866990296205, 6455.096286519891, 6529.673516324165, 6609.339066093448, 6610.471162307004, 6612.93387066128, 4535.0, 4535.0, 4535.0, 4537.342085397599, 4545.295479200663, 4580.862574122782, 4592.357070010201, 4593.747343896118, 4609.1703493371515, 4610.377599024089, 5305.389880163831, 5330.520253177233, 5334.946650533445, 5335.733213339395, 5346.625736198429, 6277.717502712298, 6440.969444888889, 6453.774117905851, 6455.7417703292285, 6458.61248325102, 1625.3823547052045, 1643.7041332560016, 1644.7861777968787, 1646.1275523972313, 1646.6459711162158, 1087.2715280761909, 1088.0479580367178, 1088.1784252889177, 1095.05277934586, 1109.2346281066039, 6214.0, 6225.159603453476, 6226.906596401058, 6228.190335256388, 6228.56400051992, 6479.319671434526, 6645.269020407752, 6650.501212409089, 6651.86696266072, 6653.201615806038, 6139.293981192131, 6197.845053873599, 6269.592476489013, 6272.09054687077, 6285.308616052231, 3597.892063238107, 3624.873129440457, 3648.0, 3648.051506608248, 3648.7628304160144, 6648.7340506379205, 6753.29090445506, 6824.283450237753, 6842.7683017056415, 6846.246912839583, 6841.828954276183, 6852.554583952027, 6853.520253582202, 6853.7943861684225, 6858.828529286708, 6784.457243420515, 6795.2185498667295, 6827.0783444235385, 6832.350926661859, 6845.349691779273, 6527.184101987252, 6676.632785196861, 6691.665416729047, 6702.7654032110595, 6708.060871478095, 6622.966885165543, 6632.375068108345, 6637.037629543785, 6638.070670106093, 6662.533622646368, 6805.251422343637, 6811.761588344582, 6826.863462730618, 6829.248782634006, 6849.315068493111, 4510.255807791677, 4527.90944181108, 4534.59188673021, 4539.046800171869, 4544.636429085599, 6570.638614876228, 6711.0, 6729.932700672931, 6740.831479213059, 6744.0, 6502.837429064311, 6515.511336649865, 6521.445677117498, 6522.119513865758, 6528.575642583217, 6340.1440805490665, 6514.315996820265, 6517.055027021151, 6524.739010439529, 6529.0, 6383.521235907233, 6385.0, 6385.457236134795, 6389.904151437825, 6396.93603063982, 6494.935050649433, 6502.772402965874, 6515.73937042513, 6535.183102112236, 6544.5418820684, 6243.937560624518, 6377.521685873671, 6383.6808159592765, 6390.488760899024, 6390.48876089921], "unit": "score", "name": "prototype.html", "value": 4852.082525787419}, {"lowerIsBetter": false, "replicates": [852.62484506817, 871.1549796697202, 877.9868301975472, 878.6134100995562, 878.7232021913101, 13454.125481843686, 13800.861991380083, 13814.79277810831, 13838.792418113737, 13869.653258668539, 13381.93309033456, 13456.461741530327, 13471.461141554326, 13475.191488510696, 13494.527691530799, 791.501354146888, 804.6660635836121, 805.2390490986021, 805.6092794994423, 805.697863301262, 657.6711644177911, 659.106910136765, 797.4497596658316, 799.348530947279, 806.435495153392, 833.154348336436, 847.3856454070811, 848.4909054567272, 849.163573879728, 850.4769566716456, 841.7895526118471, 844.2106630300689, 844.3751623798375, 844.5059640110481, 850.6087199888059, 506.39485814451746, 507.0745888753041, 612.1735656863243, 616.5684021185143, 618.4681174190193, 13059.869401306056, 13109.60671179866, 13124.934375328157, 13142.73714525704, 13143.671408214776, 11263.662090137226, 12193.268403895794, 12379.938100309531, 12393.752124957451, 12582.119251652388, 10694.197935154816, 10768.3538987661, 10829.350238985608, 10847.945760271226, 10975.725606859813, 3597.5503062117236, 3620.1854582718943, 3625.2024554597947, 3654.543182102237, 3696.9815150924073, 45391.0, 45572.088558228985, 45579.77210113961, 45791.54208457906, 46712.53287467116, 10162.39025658463, 10217.284790064772, 10259.19703262025, 10310.896891030994, 10322.741931451623, 18582.349617763583, 18621.0, 18640.34758783436, 18646.53383665419, 18649.0, 7415.036045314075, 7477.364424024019, 7503.09962804467, 7565.6973721051645, 7702.96148519265, 4251.766152861623, 4261.403403523509, 4290.442242508454, 4293.0769884474985, 4312.245357062501, 3005.834679092627, 3038.3619439917425, 3059.602251707264, 3061.724444799934, 3062.846857657108, 540.5621446628244, 552.1882832236606, 553.8620923236305, 557.83543854563, 564.4524810933389, 509.8725318670332, 547.9589030822705, 620.9875802483925, 635.5868685354465, 719.9208087110413, 8354.8329033419, 8522.74431767048, 8596.785080372916, 8668.096187777166, 8736.956315218384, 472.7069217085429, 667.2926697700453, 712.5831388637602, 725.6444342272249, 745.1840234942729, 3968.6825053995613, 4064.251027269331, 4183.958160418357, 4405.757683327448, 4555.202839503074, 51461.48538514642, 52577.7371113142, 56396.154057689164, 56506.0, 56916.14625780617, 47153.76423117931, 47201.0, 51002.74498627483, 51256.23115653268, 51324.23013654798, 44867.30796152176, 45591.54408455939, 45797.77101114473, 46379.76810115928, 46444.7677761609, 8760.561971901252, 8831.0, 8853.778655533406, 8928.598213080557, 9062.229710474683, 34723.65276347204, 35227.82386088053, 35560.82219588885, 35845.46231806577, 35886.28227435384, 41042.38436423396, 45308.32037519374, 45397.77301113605, 45591.77204113958, 46112.53887461082, 11029.61396351124, 11035.39305338214, 11147.219694621299, 11344.0, 11490.482928268415, 12741.235525868478, 12878.0, 12943.352832358532, 12989.48042078344, 13057.08600398001, 11684.298942063504, 11748.118891083031, 11792.23350482216, 12056.75886482248, 12144.878551214728, 11934.462949167482, 11981.400929953294, 12162.498878733972, 12243.32661703615, 12601.0, 11372.147088968195, 11377.146713996648, 11407.657770266906, 11464.31214127155, 11670.649880503599, 10009.299349045497, 10082.193424526167, 10107.241956853119, 10394.272400931863, 10642.680719578426, 8966.910330896608, 9275.2579793615, 10071.992800719869, 10174.745631359276, 10185.541650625592], "unit": "score", "name": "yui.html", "value": 6335.770377682798}], "name": "dromaeo_css", "value": 6896.267968602874}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 110.0, 111.0, 112.0, 101.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 152.0, 167.0, 140.0, 148.0, 150.0, 123.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 159.0, 160.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 76.0, 95.0, 71.0, 77.0, 70.0, 101.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 145.0, 93.0, 93.0, 93.0, 139.0, 95.0, 94.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 56.0, 57.0, 57.0, 58.0, 57.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 74.0, 70.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 91.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 111.0, 121.0, 129.0, 123.0, 114.0, 118.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [139.0, 156.0, 156.0, 150.0, 141.0, 145.0, 144.0, 155.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 66.0, 68.0, 69.0, 67.0, 70.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1499.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [187.9699248120301], "unit": "score", "name": "DeltaBlue", "value": 351.74775999999986}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1140.2508551881415], "unit": "score", "name": "RayTrace", "value": 648.9703529999999}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [11674.418604651162], "unit": "score", "name": "Boyer", "value": 57.08746812749006}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [698.0609418282548], "unit": "score", "name": "Splay", "value": 116.73909126984124}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20801.260315580097}]} 08:44:54 INFO - RETURN: dromaeo_css: 6896.27 08:44:54 INFO - RETURN: kraken: 1499.10 08:44:54 INFO - RETURN: v8_7: 20801.26 08:44:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20801.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1499.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6896.27"}}} 08:44:54 INFO - Return code: 0 08:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:44:54 INFO - # TBPL SUCCESS # 08:44:54 INFO - Running post-action listener: _resource_record_post_action 08:44:54 INFO - Running post-run listener: _resource_record_post_run 08:44:55 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 262144; Write bytes: 544899072; Read time: 28; Write time: 437524 08:44:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234500096; Read time: 0; Write time: 230020 08:44:55 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 262144; Write bytes: 310398976; Read time: 28; Write time: 207504 08:44:55 INFO - Running post-run listener: _upload_blobber_files 08:44:55 INFO - Blob upload gear active. 08:44:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:44:55 INFO - Copying logs to upload dir... 08:44:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.843674 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-17 08:44:55.745245) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:55.748428) ========= 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010019 build_url: 'https://queue.taskcluster.net/v1/task/g6f9hYk8T0yZYQSaZ8llyA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:55.800206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:55.800532) ========= 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=d6a7e047ef025f707024e163000001c3-1450361735.998339-246165691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:55.851033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 08:44:55.851358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 08:44:55.851657) ========= ========= Total master_lag: 0.23 =========