builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1458962520.37 results: success (0) buildid: 20160325173059 builduid: 099df49654a44b79ae4041e2d58a8558 revision: 070628989f86334dfd35ae04c5f5151bdb8589a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.371741) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.372214) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.372501) ========= 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006533 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.400320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.400624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.421882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.422291) ========= 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.478342) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.478621) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.478967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.479247) ========= 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 20:22:01-- 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% 42.5M=0s 2016-03-25 20:22:01 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.643086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.648455) ========= 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017012 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.700036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:00.700391) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 070628989f86334dfd35ae04c5f5151bdb8589a3 --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 070628989f86334dfd35ae04c5f5151bdb8589a3 --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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 20:22:01,708 truncating revision to first 12 chars 2016-03-25 20:22:01,708 Setting DEBUG logging. 2016-03-25 20:22:01,708 attempt 1/10 2016-03-25 20:22:01,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/070628989f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 20:22:02,015 unpacking tar archive at: fx-team-070628989f86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:01.330505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:01.330894) ========= echo 070628989f86334dfd35ae04c5f5151bdb8589a3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'070628989f86334dfd35ae04c5f5151bdb8589a3'] 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 070628989f86334dfd35ae04c5f5151bdb8589a3 program finished with exit code 0 elapsedTime=0.004728 script_repo_revision: '070628989f86334dfd35ae04c5f5151bdb8589a3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:01.383984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:01.384323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 20:22:01.402486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-25 20:22:01.402767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --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', '--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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:02 INFO - MultiFileLogger online at 20160325 20:22:02 in /builds/slave/test-pgo 20:22:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:22:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:22:02 INFO - {'append_to_log': False, 20:22:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:22:02 INFO - 'blob_upload_branch': 'Fx-Team', 20:22:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:22:02 INFO - 'branch': 'Fx-Team', 20:22:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:02 INFO - 'config_files': ('talos/linux_config.py',), 20:22:02 INFO - 'default_actions': ('clobber', 20:22:02 INFO - 'read-buildbot-config', 20:22:02 INFO - 'download-and-extract', 20:22:02 INFO - 'populate-webroot', 20:22:02 INFO - 'create-virtualenv', 20:22:02 INFO - 'install', 20:22:02 INFO - 'run-tests'), 20:22:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:02 INFO - 'download_minidump_stackwalk': True, 20:22:02 INFO - 'download_symbols': 'ondemand', 20:22:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:02 INFO - 'installer_path': 'installer.exe', 20:22:02 INFO - 'log_level': 'info', 20:22:02 INFO - 'log_name': 'talos', 20:22:02 INFO - 'log_to_console': True, 20:22:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:02 INFO - 'opt_config_files': (), 20:22:02 INFO - 'pip_index': False, 20:22:02 INFO - 'sps_profile': False, 20:22:02 INFO - 'sps_profile_interval': 0, 20:22:02 INFO - 'suite': 'dromaeojs', 20:22:02 INFO - 'system_bits': '32', 20:22:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:02 INFO - 'title': 'talos-linux64-ix-045', 20:22:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:02 INFO - 'use_talos_json': True, 20:22:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:22:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:02 INFO - 'work_dir': 'build'} 20:22:02 INFO - ##### 20:22:02 INFO - ##### Running clobber step. 20:22:02 INFO - ##### 20:22:02 INFO - Running pre-action listener: _resource_record_pre_action 20:22:02 INFO - Running main action method: clobber 20:22:02 INFO - rmtree: /builds/slave/test-pgo/build 20:22:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:22:02 INFO - Running post-action listener: _resource_record_post_action 20:22:02 INFO - ##### 20:22:02 INFO - ##### Running read-buildbot-config step. 20:22:02 INFO - ##### 20:22:02 INFO - Running pre-action listener: _resource_record_pre_action 20:22:02 INFO - Running main action method: read_buildbot_config 20:22:02 INFO - Using buildbot properties: 20:22:02 INFO - { 20:22:02 INFO - "project": "", 20:22:02 INFO - "product": "firefox", 20:22:02 INFO - "script_repo_revision": "production", 20:22:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:22:02 INFO - "repository": "", 20:22:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:22:02 INFO - "buildid": "20160325173059", 20:22:02 INFO - "pgo_build": "True", 20:22:02 INFO - "basedir": "/builds/slave/test-pgo", 20:22:02 INFO - "buildnumber": 564, 20:22:02 INFO - "slavename": "talos-linux64-ix-045", 20:22:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:22:02 INFO - "platform": "ubuntu64_hw", 20:22:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:22:02 INFO - "branch": "fx-team", 20:22:02 INFO - "repo_path": "integration/fx-team", 20:22:02 INFO - "revision": "070628989f86334dfd35ae04c5f5151bdb8589a3", 20:22:02 INFO - "stage_platform": "linux64-pgo", 20:22:02 INFO - "builduid": "099df49654a44b79ae4041e2d58a8558", 20:22:02 INFO - "slavebuilddir": "test" 20:22:02 INFO - } 20:22:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:22:02 INFO - Running post-action listener: _resource_record_post_action 20:22:02 INFO - ##### 20:22:02 INFO - ##### Running download-and-extract step. 20:22:02 INFO - ##### 20:22:02 INFO - Running pre-action listener: _resource_record_pre_action 20:22:02 INFO - Running main action method: download_and_extract 20:22:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:22:02 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')]} 20:22:02 INFO - https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:22:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:22:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:22:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:22:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:22:05 INFO - Downloaded 1361 bytes. 20:22:05 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:22:05 INFO - Using the following test package requirements: 20:22:05 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:22:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:22:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'jsshell-linux-x86_64.zip'], 20:22:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:22:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:22:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:22:05 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:22:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:22:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:22:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:22:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:22: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')]} 20:22:05 INFO - https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:22:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:22:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:22:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:22:06 INFO - Downloaded 23655737 bytes. 20:22:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:22:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:22:07 INFO - Return code: 0 20:22:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:07 INFO - https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:22:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:22:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:22:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:22:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:22:10 INFO - Downloaded 23655737 bytes. 20:22:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:22:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:22:12 INFO - Return code: 0 20:22:12 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')]} 20:22:12 INFO - https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:22:13 INFO - Downloaded 10847531 bytes. 20:22:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:22:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:22:13 INFO - Return code: 0 20:22: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')]} 20:22:13 INFO - https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:22:16 INFO - Downloaded 57714594 bytes. 20:22:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:22:16 INFO - mkdir: /builds/slave/test-pgo/properties 20:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:22:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:22:16 INFO - Contents: 20:22:16 INFO - build_url:https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:22:17 INFO - Running post-action listener: _resource_record_post_action 20:22:17 INFO - Running post-action listener: set_extra_try_arguments 20:22:17 INFO - ##### 20:22:17 INFO - ##### Running populate-webroot step. 20:22:17 INFO - ##### 20:22:17 INFO - Running pre-action listener: _resource_record_pre_action 20:22:17 INFO - Running main action method: populate_webroot 20:22:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:22:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:22:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:22:17 INFO - '--tppagecycles', 20:22:17 INFO - '7'], 20:22:17 INFO - 'tests': ['tsvgm']}}, 20:22:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:22:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:22:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:22:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:22:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:22:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'tests': ['damp', 'tps']}, 20:22:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['damp', 'tps']}, 20:22:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:22:17 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['dromaeo_dom']}, 20:22:17 INFO - 'other': {'tests': ['a11yr', 20:22:17 INFO - 'ts_paint', 20:22:17 INFO - 'tpaint', 20:22:17 INFO - 'sessionrestore', 20:22:17 INFO - 'sessionrestore_no_auto_restore', 20:22:17 INFO - 'tabpaint']}, 20:22:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['a11yr', 20:22:17 INFO - 'ts_paint', 20:22:17 INFO - 'tpaint', 20:22:17 INFO - 'sessionrestore', 20:22:17 INFO - 'sessionrestore_no_auto_restore', 20:22:17 INFO - 'tabpaint']}, 20:22:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['a11yr', 20:22:17 INFO - 'ts_paint', 20:22:17 INFO - 'tpaint', 20:22:17 INFO - 'sessionrestore', 20:22:17 INFO - 'sessionrestore_no_auto_restore', 20:22:17 INFO - 'tabpaint']}, 20:22:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['a11yr', 20:22:17 INFO - 'ts_paint', 20:22:17 INFO - 'tpaint', 20:22:17 INFO - 'sessionrestore', 20:22:17 INFO - 'sessionrestore_no_auto_restore', 20:22:17 INFO - 'tabpaint']}, 20:22:17 INFO - 'other_l64': {'tests': ['a11yr', 20:22:17 INFO - 'ts_paint', 20:22:17 INFO - 'tpaint', 20:22:17 INFO - 'sessionrestore', 20:22:17 INFO - 'sessionrestore_no_auto_restore', 20:22:17 INFO - 'tabpaint']}, 20:22:17 INFO - 'other_nol64': {'tests': ['a11yr', 20:22:17 INFO - 'ts_paint', 20:22:17 INFO - 'tpaint', 20:22:17 INFO - 'sessionrestore', 20:22:17 INFO - 'sessionrestore_no_auto_restore', 20:22:17 INFO - 'tabpaint']}, 20:22:17 INFO - 'svgr': {'tests': ['tsvgx', 20:22:17 INFO - 'tsvgr_opacity', 20:22:17 INFO - 'tart', 20:22:17 INFO - 'tscrollx', 20:22:17 INFO - 'cart']}, 20:22:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['tsvgx', 20:22:17 INFO - 'tsvgr_opacity', 20:22:17 INFO - 'tart', 20:22:17 INFO - 'tscrollx', 20:22:17 INFO - 'cart']}, 20:22:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'tests': ['tp5o']}, 20:22:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'talos_options': ['--e10s'], 20:22:17 INFO - 'tests': ['tp5o']}, 20:22:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'talos_options': ['--xperf_path', 20:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:17 INFO - 'tests': ['tp5n']}, 20:22:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:22:17 INFO - 'talos_options': ['--e10s', 20:22:17 INFO - '--xperf_path', 20:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:22:17 INFO - 'tests': ['tp5n']}}, 20:22:17 INFO - 'talos.zip': {'path': '', 20:22:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:22:17 INFO - Running post-action listener: _resource_record_post_action 20:22:17 INFO - ##### 20:22:17 INFO - ##### Running create-virtualenv step. 20:22:17 INFO - ##### 20:22:17 INFO - Running pre-action listener: _resource_record_pre_action 20:22:17 INFO - Running main action method: create_virtualenv 20:22:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:22:17 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 20:22:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:22:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:22:17 INFO - Using real prefix '/usr' 20:22:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:22:17 INFO - Installing distribute.............................................................................................................................................................................................done. 20:22:19 INFO - Installing pip.................done. 20:22:19 INFO - Return code: 0 20:22:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:22:19 INFO - Using env: {'DISPLAY': ':0', 20:22:19 INFO - 'HOME': '/home/cltbld', 20:22:19 INFO - 'LANG': 'en_US.UTF-8', 20:22:19 INFO - 'LANGUAGE': 'en_US:en', 20:22:19 INFO - 'LOGNAME': 'cltbld', 20:22:19 INFO - 'MAIL': '/var/mail/cltbld', 20:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:19 INFO - 'MOZ_NO_REMOTE': '1', 20:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:19 INFO - 'NO_EM_RESTART': '1', 20:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:19 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:19 INFO - 'SHELL': '/bin/bash', 20:22:19 INFO - 'SHLVL': '1', 20:22:19 INFO - 'TERM': 'linux', 20:22:19 INFO - 'TMOUT': '86400', 20:22:19 INFO - 'USER': 'cltbld', 20:22:19 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:19 INFO - '_': '/tools/buildbot/bin/python'} 20:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:20 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 20:22:20 INFO - Cleaning up... 20:22:20 INFO - Return code: 0 20:22:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:22: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')]} 20:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:22:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:22:20 INFO - Using env: {'DISPLAY': ':0', 20:22:20 INFO - 'HOME': '/home/cltbld', 20:22:20 INFO - 'LANG': 'en_US.UTF-8', 20:22:20 INFO - 'LANGUAGE': 'en_US:en', 20:22:20 INFO - 'LOGNAME': 'cltbld', 20:22:20 INFO - 'MAIL': '/var/mail/cltbld', 20:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:20 INFO - 'MOZ_NO_REMOTE': '1', 20:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:20 INFO - 'NO_EM_RESTART': '1', 20:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:20 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:20 INFO - 'SHELL': '/bin/bash', 20:22:20 INFO - 'SHLVL': '1', 20:22:20 INFO - 'TERM': 'linux', 20:22:20 INFO - 'TMOUT': '86400', 20:22:20 INFO - 'USER': 'cltbld', 20:22:20 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:20 INFO - '_': '/tools/buildbot/bin/python'} 20:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:20 INFO - Downloading/unpacking psutil>=0.7.1 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:22 INFO - Installing collected packages: psutil 20:22:22 INFO - Running setup.py install for psutil 20:22:22 INFO - building 'psutil._psutil_linux' extension 20:22:22 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 20:22:23 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 20:22:23 INFO - building 'psutil._psutil_posix' extension 20:22:23 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 20:22:23 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 20:22:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:22:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:22:23 INFO - Successfully installed psutil 20:22:23 INFO - Cleaning up... 20:22:23 INFO - Return code: 0 20:22:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:22: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')]} 20:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22: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')]} 20:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:22:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:22:23 INFO - Using env: {'DISPLAY': ':0', 20:22:23 INFO - 'HOME': '/home/cltbld', 20:22:23 INFO - 'LANG': 'en_US.UTF-8', 20:22:23 INFO - 'LANGUAGE': 'en_US:en', 20:22:23 INFO - 'LOGNAME': 'cltbld', 20:22:23 INFO - 'MAIL': '/var/mail/cltbld', 20:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:23 INFO - 'MOZ_NO_REMOTE': '1', 20:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:23 INFO - 'NO_EM_RESTART': '1', 20:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:23 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:23 INFO - 'SHELL': '/bin/bash', 20:22:23 INFO - 'SHLVL': '1', 20:22:23 INFO - 'TERM': 'linux', 20:22:23 INFO - 'TMOUT': '86400', 20:22:23 INFO - 'USER': 'cltbld', 20:22:23 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:23 INFO - '_': '/tools/buildbot/bin/python'} 20:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22: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 20:22:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:22:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:22:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:22:26 INFO - Installing collected packages: mozsystemmonitor 20:22:26 INFO - Running setup.py install for mozsystemmonitor 20:22:26 INFO - Successfully installed mozsystemmonitor 20:22:26 INFO - Cleaning up... 20:22:26 INFO - Return code: 0 20:22:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:22:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:22:26 INFO - Using env: {'DISPLAY': ':0', 20:22:26 INFO - 'HOME': '/home/cltbld', 20:22:26 INFO - 'LANG': 'en_US.UTF-8', 20:22:26 INFO - 'LANGUAGE': 'en_US:en', 20:22:26 INFO - 'LOGNAME': 'cltbld', 20:22:26 INFO - 'MAIL': '/var/mail/cltbld', 20:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:26 INFO - 'MOZ_NO_REMOTE': '1', 20:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:26 INFO - 'NO_EM_RESTART': '1', 20:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:26 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:26 INFO - 'SHELL': '/bin/bash', 20:22:26 INFO - 'SHLVL': '1', 20:22:26 INFO - 'TERM': 'linux', 20:22:26 INFO - 'TMOUT': '86400', 20:22:26 INFO - 'USER': 'cltbld', 20:22:26 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:26 INFO - '_': '/tools/buildbot/bin/python'} 20:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:26 INFO - Downloading/unpacking blobuploader==1.2.4 20:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:22:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:22:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:22:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 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 20:22:29 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 20:22:30 INFO - Downloading docopt-0.6.1.tar.gz 20:22:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:22:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:22:30 INFO - Running setup.py install for blobuploader 20:22:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:22:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:22:30 INFO - Running setup.py install for requests 20:22:30 INFO - Running setup.py install for docopt 20:22:30 INFO - Successfully installed blobuploader requests docopt 20:22:30 INFO - Cleaning up... 20:22:30 INFO - Return code: 0 20:22:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:22:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:22:30 INFO - Using env: {'DISPLAY': ':0', 20:22:30 INFO - 'HOME': '/home/cltbld', 20:22:30 INFO - 'LANG': 'en_US.UTF-8', 20:22:30 INFO - 'LANGUAGE': 'en_US:en', 20:22:30 INFO - 'LOGNAME': 'cltbld', 20:22:30 INFO - 'MAIL': '/var/mail/cltbld', 20:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:30 INFO - 'MOZ_NO_REMOTE': '1', 20:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:30 INFO - 'NO_EM_RESTART': '1', 20:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:30 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:30 INFO - 'SHELL': '/bin/bash', 20:22:30 INFO - 'SHLVL': '1', 20:22:30 INFO - 'TERM': 'linux', 20:22:30 INFO - 'TMOUT': '86400', 20:22:30 INFO - 'USER': 'cltbld', 20:22:30 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:30 INFO - '_': '/tools/buildbot/bin/python'} 20:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:22:31 INFO - Running setup.py (path:/tmp/pip-gX23VM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:22:31 INFO - Running setup.py (path:/tmp/pip-ftySmz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:22:31 INFO - Running setup.py (path:/tmp/pip-5WPmTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:22:31 INFO - Running setup.py (path:/tmp/pip-ORa17j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:22:31 INFO - Running setup.py (path:/tmp/pip-722bpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:22:31 INFO - Running setup.py (path:/tmp/pip-HvzQIO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:22:31 INFO - Running setup.py (path:/tmp/pip-OxzRCB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:22:31 INFO - Running setup.py (path:/tmp/pip-Om6IME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:22:31 INFO - Running setup.py (path:/tmp/pip-77C_7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:22:31 INFO - Running setup.py (path:/tmp/pip-YOqimm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:22:31 INFO - Running setup.py (path:/tmp/pip-i4l0PW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:22:31 INFO - Running setup.py (path:/tmp/pip-n6q0xC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:22:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:22:31 INFO - Running setup.py (path:/tmp/pip-4pLLrm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:22:32 INFO - Running setup.py (path:/tmp/pip-DxiJGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:22:32 INFO - Running setup.py (path:/tmp/pip-HZNjvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:22:32 INFO - Running setup.py (path:/tmp/pip-YWxyrX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:22:32 INFO - Running setup.py (path:/tmp/pip-Nun4fR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:22:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:22:32 INFO - Running setup.py install for manifestparser 20:22:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:22:32 INFO - Running setup.py install for mozcrash 20:22:32 INFO - Running setup.py install for mozdebug 20:22:32 INFO - Running setup.py install for mozdevice 20:22:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:22:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:22:32 INFO - Running setup.py install for mozfile 20:22:32 INFO - Running setup.py install for mozhttpd 20:22:32 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:22:32 INFO - Running setup.py install for mozinfo 20:22:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Running setup.py install for mozInstall 20:22:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Running setup.py install for mozleak 20:22:33 INFO - Running setup.py install for mozlog 20:22:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Running setup.py install for moznetwork 20:22:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Running setup.py install for mozprocess 20:22:33 INFO - Running setup.py install for mozprofile 20:22:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Running setup.py install for mozrunner 20:22:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:22:33 INFO - Running setup.py install for mozscreenshot 20:22:33 INFO - Running setup.py install for moztest 20:22:33 INFO - Running setup.py install for mozversion 20:22:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:22:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:22:34 INFO - Cleaning up... 20:22:34 INFO - Return code: 0 20:22:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:22:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:22:34 INFO - Using env: {'DISPLAY': ':0', 20:22:34 INFO - 'HOME': '/home/cltbld', 20:22:34 INFO - 'LANG': 'en_US.UTF-8', 20:22:34 INFO - 'LANGUAGE': 'en_US:en', 20:22:34 INFO - 'LOGNAME': 'cltbld', 20:22:34 INFO - 'MAIL': '/var/mail/cltbld', 20:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:34 INFO - 'MOZ_NO_REMOTE': '1', 20:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:34 INFO - 'NO_EM_RESTART': '1', 20:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:34 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:34 INFO - 'SHELL': '/bin/bash', 20:22:34 INFO - 'SHLVL': '1', 20:22:34 INFO - 'TERM': 'linux', 20:22:34 INFO - 'TMOUT': '86400', 20:22:34 INFO - 'USER': 'cltbld', 20:22:34 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:34 INFO - '_': '/tools/buildbot/bin/python'} 20:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:22:34 INFO - Running setup.py (path:/tmp/pip-XbYTVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:22:34 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:22:34 INFO - Running setup.py (path:/tmp/pip-nJZwMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:22:34 INFO - Running setup.py (path:/tmp/pip-6_uyHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:22:34 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:22:34 INFO - Running setup.py (path:/tmp/pip-f9G2dY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:22:34 INFO - Running setup.py (path:/tmp/pip-ijUpGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:22:34 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:22:34 INFO - Running setup.py (path:/tmp/pip-BoYcja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:22:34 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:22:34 INFO - Running setup.py (path:/tmp/pip-VvIYTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:22:34 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:22:34 INFO - Running setup.py (path:/tmp/pip-cQpGdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:22:34 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)) 20:22:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:22:34 INFO - Running setup.py (path:/tmp/pip-bywZ14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:22:35 INFO - Running setup.py (path:/tmp/pip-uUgv9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:22:35 INFO - Running setup.py (path:/tmp/pip-xidccl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:22:35 INFO - Running setup.py (path:/tmp/pip-w8LuWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:22:35 INFO - Running setup.py (path:/tmp/pip-CUaLsq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:22:35 INFO - Running setup.py (path:/tmp/pip-qA1JEM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:22:35 INFO - Running setup.py (path:/tmp/pip-zgBICr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:22:35 INFO - Running setup.py (path:/tmp/pip-9ttXwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:22:35 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)) 20:22:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:22:35 INFO - Running setup.py (path:/tmp/pip-LXrFtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:22:35 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)) 20:22:35 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:22:35 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:22:35 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)) 20:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:22:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:22:35 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 20:22:35 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 20:22:35 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 20:22:35 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 20:22:35 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 20:22:35 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 20:22:38 INFO - Downloading blessings-1.6.tar.gz 20:22:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:22:38 INFO - Installing collected packages: blessings 20:22:38 INFO - Running setup.py install for blessings 20:22:38 INFO - Successfully installed blessings 20:22:38 INFO - Cleaning up... 20:22:38 INFO - Return code: 0 20:22:38 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:22:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:22:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:22:39 INFO - Reading from file tmpfile_stdout 20:22:39 INFO - Current package versions: 20:22:39 INFO - argparse == 1.2.1 20:22:39 INFO - blessings == 1.6 20:22:39 INFO - blobuploader == 1.2.4 20:22:39 INFO - docopt == 0.6.1 20:22:39 INFO - manifestparser == 1.1 20:22:39 INFO - mozInstall == 1.12 20:22:39 INFO - mozcrash == 0.17 20:22:39 INFO - mozdebug == 0.1 20:22:39 INFO - mozdevice == 0.48 20:22:39 INFO - mozfile == 1.2 20:22:39 INFO - mozhttpd == 0.7 20:22:39 INFO - mozinfo == 0.9 20:22:39 INFO - mozleak == 0.1 20:22:39 INFO - mozlog == 3.1 20:22:39 INFO - moznetwork == 0.27 20:22:39 INFO - mozprocess == 0.22 20:22:39 INFO - mozprofile == 0.28 20:22:39 INFO - mozrunner == 6.11 20:22:39 INFO - mozscreenshot == 0.1 20:22:39 INFO - mozsystemmonitor == 0.0 20:22:39 INFO - moztest == 0.7 20:22:39 INFO - mozversion == 1.4 20:22:39 INFO - psutil == 3.1.1 20:22:39 INFO - requests == 1.2.3 20:22:39 INFO - wsgiref == 0.1.2 20:22:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 20:22:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:22:39 INFO - Using env: {'DISPLAY': ':0', 20:22:39 INFO - 'HOME': '/home/cltbld', 20:22:39 INFO - 'LANG': 'en_US.UTF-8', 20:22:39 INFO - 'LANGUAGE': 'en_US:en', 20:22:39 INFO - 'LOGNAME': 'cltbld', 20:22:39 INFO - 'MAIL': '/var/mail/cltbld', 20:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:39 INFO - 'MOZ_NO_REMOTE': '1', 20:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:39 INFO - 'NO_EM_RESTART': '1', 20:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:39 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:39 INFO - 'SHELL': '/bin/bash', 20:22:39 INFO - 'SHLVL': '1', 20:22:39 INFO - 'TERM': 'linux', 20:22:39 INFO - 'TMOUT': '86400', 20:22:39 INFO - 'USER': 'cltbld', 20:22:39 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:39 INFO - '_': '/tools/buildbot/bin/python'} 20:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:22:39 INFO - Cleaning up... 20:22:39 INFO - Return code: 0 20:22:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:22:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:22:39 INFO - Using env: {'DISPLAY': ':0', 20:22:39 INFO - 'HOME': '/home/cltbld', 20:22:39 INFO - 'LANG': 'en_US.UTF-8', 20:22:39 INFO - 'LANGUAGE': 'en_US:en', 20:22:39 INFO - 'LOGNAME': 'cltbld', 20:22:39 INFO - 'MAIL': '/var/mail/cltbld', 20:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:39 INFO - 'MOZ_NO_REMOTE': '1', 20:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:39 INFO - 'NO_EM_RESTART': '1', 20:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:39 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:39 INFO - 'SHELL': '/bin/bash', 20:22:39 INFO - 'SHLVL': '1', 20:22:39 INFO - 'TERM': 'linux', 20:22:39 INFO - 'TMOUT': '86400', 20:22:39 INFO - 'USER': 'cltbld', 20:22:39 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:39 INFO - '_': '/tools/buildbot/bin/python'} 20:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:39 INFO - Downloading/unpacking jsonschema 20:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:22:42 INFO - Downloading/unpacking functools32 (from jsonschema) 20:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:42 INFO - Downloading functools32-3.2.3-2.tar.gz 20:22:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:22:42 INFO - warning: no files found matching '*.txt' 20:22:42 INFO - no previously-included directories found matching 'build' 20:22:42 INFO - no previously-included directories found matching 'dist' 20:22:42 INFO - no previously-included directories found matching '.git*' 20:22:42 INFO - Installing collected packages: jsonschema, functools32 20:22:42 INFO - Running setup.py install for functools32 20:22:42 INFO - warning: no files found matching '*.txt' 20:22:42 INFO - no previously-included directories found matching 'build' 20:22:42 INFO - no previously-included directories found matching 'dist' 20:22:42 INFO - no previously-included directories found matching '.git*' 20:22:42 INFO - Successfully installed jsonschema functools32 20:22:42 INFO - Cleaning up... 20:22:42 INFO - Return code: 0 20:22:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fafc07eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x154b6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, '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': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', '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 20:22:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:22:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:22:42 INFO - Using env: {'DISPLAY': ':0', 20:22:42 INFO - 'HOME': '/home/cltbld', 20:22:42 INFO - 'LANG': 'en_US.UTF-8', 20:22:42 INFO - 'LANGUAGE': 'en_US:en', 20:22:42 INFO - 'LOGNAME': 'cltbld', 20:22:42 INFO - 'MAIL': '/var/mail/cltbld', 20:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:22:42 INFO - 'MOZ_NO_REMOTE': '1', 20:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:22:42 INFO - 'NO_EM_RESTART': '1', 20:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:22:42 INFO - 'PWD': '/builds/slave/test-pgo', 20:22:42 INFO - 'SHELL': '/bin/bash', 20:22:42 INFO - 'SHLVL': '1', 20:22:42 INFO - 'TERM': 'linux', 20:22:42 INFO - 'TMOUT': '86400', 20:22:42 INFO - 'USER': 'cltbld', 20:22:42 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:22:42 INFO - '_': '/tools/buildbot/bin/python'} 20:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:22:43 INFO - Downloading/unpacking flake8 20:22:43 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 20:22:43 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 20:22:43 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 20:22:43 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 20:22:43 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 20:22:43 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 20:22:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:22:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:22:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:22:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:22:46 INFO - no previously-included directories found matching 'docs/_build' 20:22:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:22:46 INFO - Running setup.py install for pep8 20:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:22:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:22:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:22:46 INFO - no previously-included directories found matching 'docs/_build' 20:22:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:22:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:22:46 INFO - Cleaning up... 20:22:46 INFO - Return code: 0 20:22:46 INFO - Running post-action listener: _resource_record_post_action 20:22:46 INFO - Running post-action listener: _start_resource_monitoring 20:22:46 INFO - Starting resource monitoring. 20:22:46 INFO - ##### 20:22:46 INFO - ##### Running install step. 20:22:46 INFO - ##### 20:22:46 INFO - Running pre-action listener: _resource_record_pre_action 20:22:46 INFO - Running main action method: install 20:22:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:22:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:22:47 INFO - Reading from file tmpfile_stdout 20:22:47 INFO - Detecting whether we're running mozinstall >=1.0... 20:22:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:22:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:22:47 INFO - Reading from file tmpfile_stdout 20:22:47 INFO - Output received: 20:22:47 INFO - Usage: mozinstall [options] installer 20:22:47 INFO - Options: 20:22:47 INFO - -h, --help show this help message and exit 20:22:47 INFO - -d DEST, --destination=DEST 20:22:47 INFO - Directory to install application into. [default: 20:22:47 INFO - "/builds/slave/test-pgo"] 20:22:47 INFO - --app=APP Application being installed. [default: firefox] 20:22:47 INFO - mkdir: /builds/slave/test-pgo/build/application 20:22:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:22:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:23:03 INFO - Reading from file tmpfile_stdout 20:23:03 INFO - Output received: 20:23:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:23:03 INFO - Running post-action listener: _resource_record_post_action 20:23:03 INFO - ##### 20:23:03 INFO - ##### Running run-tests step. 20:23:03 INFO - ##### 20:23:03 INFO - Running pre-action listener: _resource_record_pre_action 20:23:03 INFO - Running main action method: run_tests 20:23:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:23:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:23:03 INFO - Python 2.7.3 20:23:03 INFO - Return code: 0 20:23:03 INFO - grabbing minidump binary from tooltool 20:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:23:03 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 0x15461d0>, '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 0x1549750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1549be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:23:03 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 20:23:03 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 20:23:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:23:03 INFO - Return code: 0 20:23:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:23:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:23:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:23:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:23:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:23:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:23:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:23:04 INFO - Return code: 0 20:23:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 20:23:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 20:23:04 INFO - Using env: {'DISPLAY': ':0', 20:23:04 INFO - 'HOME': '/home/cltbld', 20:23:04 INFO - 'LANG': 'en_US.UTF-8', 20:23:04 INFO - 'LANGUAGE': 'en_US:en', 20:23:04 INFO - 'LOGNAME': 'cltbld', 20:23:04 INFO - 'MAIL': '/var/mail/cltbld', 20:23:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:23:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:23:04 INFO - 'MOZ_NO_REMOTE': '1', 20:23:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:23:04 INFO - 'NO_EM_RESTART': '1', 20:23:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:23:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:23:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:23:04 INFO - 'SHELL': '/bin/bash', 20:23:04 INFO - 'SHLVL': '1', 20:23:04 INFO - 'TERM': 'linux', 20:23:04 INFO - 'TMOUT': '86400', 20:23:04 INFO - 'USER': 'cltbld', 20:23:04 INFO - 'XDG_SESSION_COOKIE': '1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413', 20:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:23:04 INFO - '_': '/tools/buildbot/bin/python'} 20:23:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:23:04 INFO - mozversion application_buildid: 20160325173059 20:23:04 INFO - mozversion application_changeset: 070628989f86334dfd35ae04c5f5151bdb8589a3 20:23:04 INFO - mozversion application_display_name: Nightly 20:23:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:23:04 INFO - mozversion application_name: Firefox 20:23:04 INFO - mozversion application_remotingname: firefox 20:23:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:23:04 INFO - mozversion application_vendor: Mozilla 20:23:04 INFO - mozversion application_version: 48.0a1 20:23:04 INFO - mozversion platform_buildid: 20160325173059 20:23:04 INFO - mozversion platform_changeset: 070628989f86334dfd35ae04c5f5151bdb8589a3 20:23:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:23:04 INFO - mozversion platform_version: 48.0a1 20:23:04 INFO - using testdate: 1458962584 20:23:04 INFO - actual date: 1458962584 20:23:04 INFO - starting webserver on 'localhost:36694' 20:23:04 INFO - SUITE-START | Running 2 tests 20:23:04 INFO - TEST-START | dromaeo_css 20:23:04 INFO - operating with platform_type : linux_ 20:23:04 INFO - Initialising browser for dromaeo_css test... 20:23:04 INFO - TEST-INFO | started process 21704 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZQ7aBM/profile http://localhost:36694/getInfo.html) 20:23:08 INFO - PROCESS | 21704 | __metrics Screen width/height:1600/1200 20:23:08 INFO - PROCESS | 21704 | colorDepth:24 20:23:08 INFO - PROCESS | 21704 | Browser inner width/height: 1024/697 20:23:08 INFO - PROCESS | 21704 | __metrics 20:23:09 ERROR - PROCESS | 21704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:23:09 INFO - PROCESS | 21704 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:23:10 INFO - TEST-INFO | 21704: exit 0 20:23:10 INFO - Browser initialized. 20:23:10 INFO - Running cycle 1/1 for dromaeo_css test... 20:23:10 INFO - TEST-INFO | started process 21798 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZQ7aBM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:21 INFO - PROCESS | 21798 | RSS: Main: 153116672 20:23:21 INFO - PROCESS | 21798 | 20:24:13 INFO - PROCESS | 21798 | 1458962653511 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] 20:26:19 INFO - PROCESS | 21798 | Cycle 1(1): loaded http://localhost:36694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36694/tests/dromaeo/cssquery-ext.html) 20:26:20 INFO - PROCESS | 21798 | RSS: Main: 262971392 20:26:20 INFO - PROCESS | 21798 | 20:29:23 INFO - PROCESS | 21798 | Cycle 1(1): loaded http://localhost:36694/tests/dromaeo/cssquery-ext.html (next: http://localhost:36694/tests/dromaeo/cssquery-jquery.html) 20:29:23 INFO - PROCESS | 21798 | RSS: Main: 236122112 20:29:23 INFO - PROCESS | 21798 | 20:32:25 INFO - PROCESS | 21798 | Cycle 1(1): loaded http://localhost:36694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36694/tests/dromaeo/cssquery-mootools.html) 20:32:26 INFO - PROCESS | 21798 | RSS: Main: 227303424 20:32:26 INFO - PROCESS | 21798 | 20:35:27 INFO - PROCESS | 21798 | Cycle 1(1): loaded http://localhost:36694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36694/tests/dromaeo/cssquery-prototype.html) 20:35:28 INFO - PROCESS | 21798 | RSS: Main: 217694208 20:35:28 INFO - PROCESS | 21798 | 20:38:30 INFO - PROCESS | 21798 | Cycle 1(1): loaded http://localhost:36694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36694/tests/dromaeo/cssquery-yui.html) 20:38:31 INFO - PROCESS | 21798 | RSS: Main: 216346624 20:38:31 INFO - PROCESS | 21798 | 20:41:33 INFO - PROCESS | 21798 | Cycle 1(1): loaded http://localhost:36694/tests/dromaeo/cssquery-yui.html (next: http://localhost:36694/tests/dromaeo/cssquery-dojo.html) 20:41:34 INFO - PROCESS | 21798 | RSS: Main: 260087808 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | __start_tp_report 20:41:34 INFO - PROCESS | 21798 | _x_x_mozilla_page_load 20:41:34 INFO - PROCESS | 21798 | _x_x_mozilla_page_load_details 20:41:34 INFO - PROCESS | 21798 | |i|pagename|runs| 20:41:34 INFO - PROCESS | 21798 | |0;dojo.html;2987.7609791216705;3045.7411120054794;3056.465118604244;3085.1207405889327;3114.6106736657925;5012.047710934919;5126.41046279678;5169.1987741899975;5189.974050129754;5220.060389129955;5213.296205012322;5231.24146998685;5232.3459567554055;5235.633505654596;5306.177542480922;4675.368825208604;4706.647001474895;4744.169770290203;4777.235642297233;4810.615150787946;4556.9088618227615;4750.16872047392;4796.952030479702;4816.494268101851;4817.349657796188;4740.19416699162;4760.238361862085;4763.857084287442;4766.3088852116425;4818.277258411232;4727.101850648366;4728.148933192024;4744.881377965544;4749.548792864673;4786.090642777861;4551.135284296006;4663.813447462131;4703.15343238217;4710.717356958594;4753.3582966299455;5149.76826042829;5178.223266510016;5180.119379705459;5182.352205974254;5191.351081114861;5534.1975413564805;5551.278333816578;5551.861203469905;5568.220449137084;5613;5489.945100548984;5589.049861523551;5635.49280564747;5716.57125715573;5722.656640601535;5093.108705976476;5094.1849304111165;5095.31213286209;5103.464136265676;5112.3865136183895;5577;5577.470140336662;5579.107342825128;5579.497845193952;5586.273784408001;5377.300950876439;5438.184272359178;5468.671879687152;5516.034693928546;5535.778568857281;5583.944160558342;5598.552115830724;5602.2717046783655;5602.52378547828;5604.243427137284;5269.657472264291;5588.692621905834;5603.7173174283835;5607.102863541813;5607.43925607436;5617;5653;5658.122990936329;5662.660240385508;5704.543636509069;4213.0310028693575;4222.4299719538085;4235.8729238122905;4236.216299984513;4275.40144379787;3721.1813401051727;3770.170562476251;3802.524684414448;3811.1424929390664;3839.4432807242792;5268.868278293074;5292.52367286946;5296.814611488579;5324.840254792362;5349.839504814861;5572.58205634579;5596.664200148004;5599.832005039855;5601.29983752031;5603.691796951207;5175.094358487249;5202.193659982633;5299.867503312448;5313.920291195635;5362.302900622894;4850.539198776181;4856.368672072608;4866.853994380174;4879.902401951941;4896.4858689837765;5805.912911306334;5808.157817116579;5811.738471768781;5814.738336774855;5833.38749431312;5519.116941289535;5593.888122237614;5611.3266408031295;5701.344345400166;5720.6853623049465;5765.1928729977;5794.884102318014;5796.159556864315;5799.565032622654;5800.4489573490455;5467.835964921059;5475.370332411664;5475.370332411823;5478.671279723229;5481.342238931354;5425.294711687456;5530.059889818821;5581.665100094007;5592.916106258491;5627.296587926509;5392.05639013179;5400.9459905400445;5402.378726446509;5413.53984911287;5421.484958928895;5241.449647786927;5386.057439947915;5386.326709161355;5386.326709161355;5441;5411.648242864201;5458.099413596712;5478;5482.23248745168;5521.171824226398;5524.171374293888;5534.501894829485;5558.666480011212;5570.053090974625;5574.414686457863;5204.2714020036465;5324.866878328073;5426.348838139448;5451.945480545302;5496.065668836228 20:41:34 INFO - PROCESS | 21798 | |1;ext.html;556.7241689215779;577.5639392258846;579.1602176843577;593.631948192121;596.3410431473224;29652.258693532673;30036.249093772665;37864.242715145716;38113.237735245275;38318.808405958;41251.38122928151;41328.79335603325;41851.581484185146;41853.58146418535;41878.16243675125;8780.297576193905;8995.280377569812;8995.550222488882;8999.820003599923;9004.639814407416;8647.65409383627;8737.868931966026;8744.737657870273;8745;8751.649934002633;8773.166549177819;8812.647494100229;8849.95575022124;8870.93548774148;8881.111888811132;8753.7811554711;8779.473231606124;8843.380963332569;8851.513166775825;8864.0692727264;8760.12398760119;8881.023087460375;8887.644494220289;8891.688790892353;8897.777555561099;40941.1811763766;41087.58912410867;41113;41168.38247426291;41174.38238426396;3330.7834990725523;3497.5278337424375;4092.3247664135383;4151.3150330195485;4266.552012038722;30847.845760771277;30896.691033089606;31028.37943241145;31084.067477975696;32666.183345416317;4320.9135817283795;4336.91326173478;4366.737995720236;4500.167469018242;4593.747343896118;297972;300323;301606;301937;302032;53114.46885531095;58997.705011475526;59126;60376.094358584654;61749.073763893575;55952;55999.440005600234;56146;56359.43640563624;56374;15283.46507872219;15418.537443876701;15421.151836648867;15436.15101169424;15450.459233926758;11528.193026488065;12596.496140154475;12825.679358015937;12978.870211297766;12980.870191298154;18900.338488152847;18953.526161846064;19020.809791902182;19087;19139.2344306229;6774.356436138559;6991.825204369931;7138.107736532934;7319.268073192638;7319.707211711579;1013.3970287678819;1033.720895358249;1107.7950579142885;1151.1251448898897;1179.6520026592175;31650;31798.364032719215;31889.362212755615;31971.200719982186;32365.676343236737;1043.6555936540924;1097.1497089755503;1098.5386137822134;1161.866385365677;1162.7558212775243;15777.763333550007;16386.180690965404;16515.58711032234;16587.502374928772;16745.246463909152;373479;381646;381657;382385;382812;55571;55816.441835581936;56244.43755562474;56248.71875640677;56267.43732562704;1273.757985982679;1292.702678383977;1400.6078298076352;1423.978640320396;1430.29915341484;27759.861200693867;29245.85377073101;29527;29746.702532975258;29869.70130298756;41272;41471.7926410366;41639.583604164785;41735.373969389875;41796.16407671769;244600;245494;250687;250985;251690;30325.545116822825;30953.535696964114;33226;33466.16334591557;34031;40772.1845563093;40860.59139408568;41177;41447.792761037206;41605.58394416017;35577.64422355847;37479;38330.0417489565;38896.80551597224;39182.412263815495;37052.41204657681;37072.25855482929;37907;38260.42609360806;38705.6129438702;37837.24325513419;37982.62017379901;39752.204955901296;40658.390124148755;40737.59262407338;30255.848720757134;31686.524702129947;32232.677673223905;32310.515342269413;32459.837700811346;25041.74958250394;25447.745522544537;25481.745182547937;25533.744662553137;25838.354041149123 20:41:34 INFO - PROCESS | 21798 | |2;jquery.html;366.32961680125374;371.5448575495019;374.3841380928375;378.9588551871233;382.33282921302333;17391;18135.183916723745;18257.269709211614;18571.90714046428;18616.25534978599;16791.83208167918;17028.659426811457;17662;17686.823131768677;17687.204075816586;5523.7790488380515;5679.971600141994;5706.201131841545;5717.8570535736735;5721.113227449731;4133.090720041586;5594.49649531542;5993.700314984255;6247.500199983991;6273.435390814826;6195.5663103582765;6205.596636218654;6217.471514921237;6225.190725205717;6227.719752611143;5952.345242023374;6140.201773769426;6141.877162456748;6144.784932527385;6150.077488376757;3767.2465506898457;5177.948220517822;5395.082835917903;5399.163129714901;5410.404855465896;20074;20161.596768064555;20276.898615506827;21665.241716540004;21684.132634694593;2256.9210077647203;2285.6800047993293;2453.1046168148678;2459.6433517140094;2498.088197807787;7064.576125432491;7156.069710937597;7944.523328600302;13516.864831351659;13674.49580546139;1899.3627203904507;1962.4505138561226;2024.9493762655904;2112.207922029239;2115.312523429876;71141;71395.64302178456;72018.63990680066;73142.63428682876;73953;10080.74798130038;10294;10381.688549343531;10408.843867341995;10520.894791052144;14564.49024284145;14658.706825863423;14689.92655036718;14692.92653536747;14696.779548306784;7591.734289299848;7841;7919.762407127795;7969.72105976288;8014.479058861155;7538.811529711801;7592.81017974555;7665.770026899202;7667.472962437229;7677.539347639159;4479.574440428154;4492.550744925481;4492.595666390041;4510.782088835996;4608;1740.617064245864;1806.1420825107969;3095.4582947984013;3172.5241213818113;3216.7748257621743;903.2457897655531;937.9437233765996;952.7284723853669;957.7174733453647;1052.5263631365915;16908.661826763397;17327.826721732872;18133.90933045326;18285.354318111433;18759.90620046891;994.572333896417;1023.7542989682422;1028.2339656955617;1038.2991480750463;1040.7086015915556;8953.910460895308;10427.530761115768;10432.321899076536;10436.478176091317;10478.117028061333;536534;539280;546838;553656;553889;85977.5701121503;86516;87304.56347718221;89841;90475.54762226147;1008.2841182760322;1009.2632378363688;1011.9949400252951;1032.194887987371;1036.4558606731525;16120.67758644844;16240;16265.43070992557;16355.182240888145;16547.089910055063;36947.815260923526;37573.43639845459;38647.6135238644;38924.80537597294;38939.221215574966;49154;49530;51950.74024629853;55437.7228113873;55825;8102.675892964216;8332.458390204618;8448.619812108593;8505.532195729294;8549.572521373782;12285.815712764137;13046.217226966412;13193.604191873876;13216.339183040618;13328.600141995756;11573.710657233636;11715.472803723682;11734.471948762155;11808.35054072;12160.270383777002;11023.669289921316;11265.7746845061;11309.377984210947;11428.48571814287;11480.425978700865;11157.386343751172;11932.940335298616;11981.460834262654;12048.578299759467;12302.446389912655;8069.435139540175;8284.83430331402;8324.292435143081;8423.70517031901;8489.278411335106;11732.530698771954;11983.460744266704;12005.63983080509;12144.574939877062;12239.75520489603 20:41:34 INFO - PROCESS | 21798 | |3;mootools.html;1358.300475255243;1463.246428089534;1478.8151481064865;1641.2778377513894;1791.578978939948;7191.748288809893;7374.926250737498;7386.593737344444;7393.7781866543955;7394.667239974201;7281.635918204095;7412.703491860319;7413.221611730772;7417.666205020773;7420.777376678709;1874.3814541201439;2185.4536365908525;2229.398062523122;2231.520223152022;2248.1119957616734;2173.4892300309416;2181.0730439563204;2181.6727490876337;2186.4424571734266;2187.004912764696;2125.3730149605904;2236.8434209605334;2238.4963383238724;2240.0815665577115;2240.7535171131244;2171.283476452767;2204.7023651806962;2212.236778311496;2213.690083388327;2216.3018649125474;2198.9450263743533;2205.9558808823895;2212.3805334506364;2214.579229946305;2230.810381117607;7439.181690014094;7556.7355142570295;7561.281678240558;7564.886526702104;7565.35694465971;4583.610393116589;4677.0178262564905;4682.555157260055;4688.062387522509;4688.906221875543;2918.7664986801005;3002.384511175204;3002.8348440835744;3040.2703351195773;3073.339232065094;992.811365840488;998.975025624358;1006.3710181136789;1023.728711891342;1027.7584767579613;10221.437820919771;10230.130438912702;10244.28290019699;10256.333338332985;10268.640597579124;4000.0399904022825;4100.979495102565;4136.607022332873;4204.26425375558;4212.094399704017;8854.690085846965;8871.245944094695;8882.0673829247;8885.866711999326;8893.599788009426;4103.056297051695;4723.811047558128;4729.929051064237;4738.407699037621;4740.857774266778;4235.894102647459;4278.978605106954;4286.121345124242;4306.720063195882;4332.610065094157;3563.6080031196548;3616.6021737608844;3650;3674.559052913614;3702.7593206441493;1168.9123315751353;1169.6432588060723;1172.267332916927;1175.5474142455216;1178.6464060781732;1113.3542545323692;1122.085500317239;1253.2104773992326;1380.5444203412849;1387.833459984788;7210.134783825974;7268.127824660969;7366.815829604303;7416.480846340704;7424.888626670604;448.6253977928401;449.43146919146653;449.94150760400936;452.01460815422035;468.51274674338987;5679.460451257124;5729.25519682447;5733.226014487991;5754.482096611325;5789.855253618609;8673.219410253107;8865.911340886509;9220.769480763034;9227.86158207614;9231.538423078953;9084.40951338161;9099.772505687411;9120.635174593075;9137.08629137081;9168.312376571785;7134.571925684476;7149.785506434815;7200.243974382719;7225.530340527849;7227.241139680468;7038.436925046087;7065.929340706527;7067.752628657972;7071.82320441993;7091.9290807091265;8118.9188108120525;8303.875441868257;8313.33493320545;8420.200080992296;8464.026636936831;8170.754877353689;8218.260356567938;8234.423590348619;8342.582870856311;8373.078961314372;6641.501887358564;6730.596164230162;6822.829429264109;6825.215100263533;6827.249002609609;7144.3570078693165;7146.964265178641;7172.318629730167;7177.784666460015;7181.138263408425;6455.61266324022;6665.533412661067;6738.292479289604;6772.085768421397;6773.6951837168435;6616.338366163345;6671.166104236971;6700.899486507608;6723.731050757915;6795.116634837439;6891.448684105159;6926.307369263235;6979.860402792017;6982.266861979622;6989.47578931572;6395.552311338161;6410.423061924449;6441.420272175526;6445.097686323825;6453.967730161319;6407.199100112486;6442.452391546771;6454.031895215755;6459.580127291711;6474.805755827333 20:41:34 INFO - PROCESS | 21798 | |4;prototype.html;326.0837047895414;326.8676186144611;328.1075474708793;333.2684756958474;341.43322085338343;5848.4736373726355;5866.882662346756;5904.734286957087;5914.85212869678;5917.408259174075;5787.536997040237;5792.275965504312;5793.681347525895;5804.158397032428;5805.680687562182;4327.891802704926;4484.282514797633;4522.344260082286;4552.817887284521;4592.334111553822;4575.38232338635;4580.290055041457;4591.44902611687;4598.816047358118;4604.6776725629215;4537.2286711259;4541.909161816761;4545.499995000564;4548.363229147922;4559.452865656126;4254.064105896698;4447.911041779179;4494.70784399013;4532.773361331921;4534.523874993111;3998.7600743955454;4003.219372222418;4010.8796736097966;4012.6388625023596;4019.577944315834;5705.486506214419;5716.542676585905;5717.113847353667;5717.170505438261;5721.113227449752;5298.841034768963;5301.469853014706;5309.734513274321;5310.654807437504;5313.203019547061;6226.40849119333;6257;6257.8748425031245;6268.840264551072;6274.811755647338;4219.556946520602;4350.8912277193;4361.367601697768;4462.3975763271865;4466.12910482456;6463.482921366326;6496.415322620986;6512.055751915993;6531.24890637578;6531.24890637578;4438.667099967515;4446.555344465528;4446.577575130357;4449.621782148489;4453.51011388747;4505.932411013838;4508.864734057984;4510.458744950562;4513.029698614813;4514.458265008155;5213.973930130325;5219.5041471060185;5222.164453687392;5223.033738758342;5230.947690523122;6161.291451483136;6305.4009869062365;6307.369263073656;6318.905216421757;6322.747090116436;1551.6586351002761;1554.2772610736063;1561.960950976212;1562.0315404449314;1563.499680102379;957.7940742740344;984.7045886234245;1004.7387679203459;1035.53400969564;1048.6067724603274;6029.758809647565;6050.334463209044;6091.116788065706;6103.694815259308;6103.877922441615;6448.226212854393;6449.613023218528;6464.612123272619;6466.773662921775;6467.062275969958;6084.9351363511205;6094.542909281821;6096.908546371808;6102;6103.542234332443;3449.085992212066;3462.1344663834043;3467.8439470223902;3476.5828100628087;3487.511748355232;6608.570442921195;6706.765263215764;6739.764108256188;6746.392824645805;6751.291114433012;6508.707108180143;6550.213974323112;6558.016297555405;6558.409743123142;6559.672016399257;6693.665316734144;6694.765683201064;6710.027046078291;6713.0937323461685;6735.259121496631;6364.64994425311;6404.295527491879;6404.647744374104;6412.422881940648;6421.486281097595;6200.968995154995;6303.338149494237;6305.5901366411035;6336.112944187726;6350.682465876595;6662.900056499253;6695.4978376620975;6700.731970721116;6706.161729783777;6711.261761206166;4462.308342206963;4472.530384309731;4473.977630111829;4479.104179164115;4479.17135329965;6392.137061496638;6414.743410263537;6415.3263907289065;6420.7431702731365;6422.036694495863;6215.316315205414;6252.437280644764;6252.749890004531;6259.812205633838;6271.247450305992;6059.394060593905;6197.876042479035;6213.1922850029205;6223.782167624111;6228.657423841551;6095.908561371494;6110.663913484623;6111.297200821962;6128.908066378919;6132.724027418866;6233.750649974132;6254.562180647493;6264.812055638338;6265.404786545453;6269.843253918689;5968.283805943314;6056.091586262096;6127.601705889103;6128.111423843607;6128.417800308964 20:41:34 INFO - PROCESS | 21798 | |5;yui.html;724.9891251631224;786.7797016835286;827.7185756842672;830.2610676497922;858.6393714639851;13918.721625567483;14026.789598156036;14038.157710537374;14092.718145637094;14120.717585648294;12221.38893055346;13586.388612512435;13615.115017523854;13686.452541898338;13719.382627781748;797.1669605262515;809.6073404398862;812.8414959082982;813.0446725097986;814.4543156085407;807.9012542941595;808.0908977400425;808.2564041082219;809.6963638635511;815.339574944297;849.2993280543545;850.4344610833788;852.1435956863374;853.0744142605281;862.5169904853271;847.3306088190322;847.3898792869124;849.668629234599;850.4557083466586;852.9914700853005;623.2303105664546;623.7504998000836;623.8596315828947;624.3007831229053;624.5908929651085;13056.477740890354;13082.345882705828;13091.869081309256;13100.737985240241;13137.211767293993;12220.450079746433;12242.510299588006;12366.258024518467;12460.937695311555;12658.240505569604;10477.790444191074;10708;10871.130309575216;10985.340879547173;11072;3794.943075853837;4397.5602439756085;4459.866204013852;4639.907201855977;4641.141388843041;46471;48952;49364.50635493635;51247.74376128095;53767.46232537625;10602.151827853753;10786.94606526978;10850.72873178161;11171.94414027941;11203.775924481464;18472.261109555737;18514.074296285402;18520.351787687367;18530.16614252362;18561;8162.3878209134555;8170.264676179054;8283.213094755989;8301.543415112106;8655.523946182895;4742.288656701522;4787.952120478821;4840.709557426566;4900.338454308623;5069.949300506948;3073.6772638873044;3120.5163199704084;3163.8892638757534;3165.082126183427;3166.794158379744;562.1511517608441;579.5913880714087;581.8516278348994;582.8892510423007;585.5520526797004;543.4646872830259;600.6006006005957;610.2768219659717;692.8614277144491;720.9387202087777;8455.830883382298;8643.956780216058;8863.379563430626;8952.328575356874;8982.640694372152;571.8570357410647;607.341034977046;637.1366797988751;638.285120664849;657.9572327798678;3956.7032472564674;4071.918561628751;4079.204555111784;4165.333546632524;4296.871093867189;59104.40895591075;59155.70422147862;59319;59644;59671.10493342603;52440;53421.1986820198;53891.730541347046;54516;54797.72601137048;41730;44423.33364999528;48781.75609122003;50000;52815.207771883455;9253.167214950687;9453.527323633929;9455.574499147693;9524.809503810024;9526.952365238129;36848.44727329146;36909.630903691694;37653.62346376611;37968;38231.04422389463;45637.31544026776;46891.76554117344;46957.53042469532;47658.761706191246;48126.278105829144;11367;11550.88449115498;11560.248583842023;11590.594329198437;11664.766704666028;12528.874711253135;12598.433070512032;12653.74692506163;12707.301098439675;12830.10189286741;12944.09391342597;12944.482220711066;12966.22202667843;12987.28569928663;12991.220526768424;12146.392680366123;12489.625311240678;12561.309127997682;12626.621201363974;12922.483100675867;12006.699832504257;12230;12706.174098683556;12931.676708082374;13212.141210821266;10269.794604108025;10303.175745940456;10333.338328662725;10348.979530912673;10609.363438193734;10533.473326333806;10582.206334525095;10653.680389588324;10700.785984280426;10840.403777792297 20:41:34 INFO - PROCESS | 21798 | __end_tp_report 20:41:34 INFO - PROCESS | 21798 | __start_cc_report 20:41:34 INFO - PROCESS | 21798 | _x_x_mozilla_cycle_collect,830 20:41:34 INFO - PROCESS | 21798 | __end_cc_report 20:41:34 INFO - PROCESS | 21798 | __startTimestamp1458963694133__endTimestamp 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | ------- Summary: start ------- 20:41:34 INFO - PROCESS | 21798 | Number of tests: 6 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | [#0] dojo.html Cycles:165 Average:5180.21 Median:5386.33 stddev:589.27 (10.9%) stddev-sans-first:565.42 20:41:34 INFO - PROCESS | 21798 | Values: 2987.8 3045.7 3056.5 3085.1 3114.6 5012.0 5126.4 5169.2 5190.0 5220.1 5213.3 5231.2 5232.3 5235.6 5306.2 4675.4 4706.6 4744.2 4777.2 4810.6 4556.9 4750.2 4797.0 4816.5 4817.3 4740.2 4760.2 4763.9 4766.3 4818.3 4727.1 4728.1 4744.9 4749.5 4786.1 4551.1 4663.8 4703.2 4710.7 4753.4 5149.8 5178.2 5180.1 5182.4 5191.4 5534.2 5551.3 5551.9 5568.2 5613.0 5489.9 5589.0 5635.5 5716.6 5722.7 5093.1 5094.2 5095.3 5103.5 5112.4 5577.0 5577.5 5579.1 5579.5 5586.3 5377.3 5438.2 5468.7 5516.0 5535.8 5583.9 5598.6 5602.3 5602.5 5604.2 5269.7 5588.7 5603.7 5607.1 5607.4 5617.0 5653.0 5658.1 5662.7 5704.5 4213.0 4222.4 4235.9 4236.2 4275.4 3721.2 3770.2 3802.5 3811.1 3839.4 5268.9 5292.5 5296.8 5324.8 5349.8 5572.6 5596.7 5599.8 5601.3 5603.7 5175.1 5202.2 5299.9 5313.9 5362.3 4850.5 4856.4 4866.9 4879.9 4896.5 5805.9 5808.2 5811.7 5814.7 5833.4 5519.1 5593.9 5611.3 5701.3 5720.7 5765.2 5794.9 5796.2 5799.6 5800.4 5467.8 5475.4 5475.4 5478.7 5481.3 5425.3 5530.1 5581.7 5592.9 5627.3 5392.1 5400.9 5402.4 5413.5 5421.5 5241.4 5386.1 5386.3 5386.3 5441.0 5411.6 5458.1 5478.0 5482.2 5521.2 5524.2 5534.5 5558.7 5570.1 5574.4 5204.3 5324.9 5426.3 5451.9 5496.1 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | [#1] ext.html Cycles:180 Average:47927.42 Median:382021.00 stddev:82498.96 (21.6%) stddev-sans-first:82653.72 20:41:34 INFO - PROCESS | 21798 | Values: 556.7 577.6 579.2 593.6 596.3 29652.3 30036.2 37864.2 38113.2 38318.8 41251.4 41328.8 41851.6 41853.6 41878.2 8780.3 8995.3 8995.6 8999.8 9004.6 8647.7 8737.9 8744.7 8745.0 8751.6 8773.2 8812.6 8850.0 8870.9 8881.1 8753.8 8779.5 8843.4 8851.5 8864.1 8760.1 8881.0 8887.6 8891.7 8897.8 40941.2 41087.6 41113.0 41168.4 41174.4 3330.8 3497.5 4092.3 4151.3 4266.6 30847.8 30896.7 31028.4 31084.1 32666.2 4320.9 4336.9 4366.7 4500.2 4593.7 297972.0 300323.0 301606.0 301937.0 302032.0 53114.5 58997.7 59126.0 60376.1 61749.1 55952.0 55999.4 56146.0 56359.4 56374.0 15283.5 15418.5 15421.2 15436.2 15450.5 11528.2 12596.5 12825.7 12978.9 12980.9 18900.3 18953.5 19020.8 19087.0 19139.2 6774.4 6991.8 7138.1 7319.3 7319.7 1013.4 1033.7 1107.8 1151.1 1179.7 31650.0 31798.4 31889.4 31971.2 32365.7 1043.7 1097.1 1098.5 1161.9 1162.8 15777.8 16386.2 16515.6 16587.5 16745.2 373479.0 381646.0 381657.0 382385.0 382812.0 55571.0 55816.4 56244.4 56248.7 56267.4 1273.8 1292.7 1400.6 1424.0 1430.3 27759.9 29245.9 29527.0 29746.7 29869.7 41272.0 41471.8 41639.6 41735.4 41796.2 244600.0 245494.0 250687.0 250985.0 251690.0 30325.5 30953.5 33226.0 33466.2 34031.0 40772.2 40860.6 41177.0 41447.8 41605.6 35577.6 37479.0 38330.0 38896.8 39182.4 37052.4 37072.3 37907.0 38260.4 38705.6 37837.2 37982.6 39752.2 40658.4 40737.6 30255.8 31686.5 32232.7 32310.5 32459.8 25041.7 25447.7 25481.7 25533.7 25838.4 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | [#2] jquery.html Cycles:180 Average:29675.75 Median:1791.55 stddev:89548.10 (4998.4%) stddev-sans-first:89772.26 20:41:34 INFO - PROCESS | 21798 | Values: 366.3 371.5 374.4 379.0 382.3 17391.0 18135.2 18257.3 18571.9 18616.3 16791.8 17028.7 17662.0 17686.8 17687.2 5523.8 5680.0 5706.2 5717.9 5721.1 4133.1 5594.5 5993.7 6247.5 6273.4 6195.6 6205.6 6217.5 6225.2 6227.7 5952.3 6140.2 6141.9 6144.8 6150.1 3767.2 5177.9 5395.1 5399.2 5410.4 20074.0 20161.6 20276.9 21665.2 21684.1 2256.9 2285.7 2453.1 2459.6 2498.1 7064.6 7156.1 7944.5 13516.9 13674.5 1899.4 1962.5 2024.9 2112.2 2115.3 71141.0 71395.6 72018.6 73142.6 73953.0 10080.7 10294.0 10381.7 10408.8 10520.9 14564.5 14658.7 14689.9 14692.9 14696.8 7591.7 7841.0 7919.8 7969.7 8014.5 7538.8 7592.8 7665.8 7667.5 7677.5 4479.6 4492.6 4492.6 4510.8 4608.0 1740.6 1806.1 3095.5 3172.5 3216.8 903.2 937.9 952.7 957.7 1052.5 16908.7 17327.8 18133.9 18285.4 18759.9 994.6 1023.8 1028.2 1038.3 1040.7 8953.9 10427.5 10432.3 10436.5 10478.1 536534.0 539280.0 546838.0 553656.0 553889.0 85977.6 86516.0 87304.6 89841.0 90475.5 1008.3 1009.3 1012.0 1032.2 1036.5 16120.7 16240.0 16265.4 16355.2 16547.1 36947.8 37573.4 38647.6 38924.8 38939.2 49154.0 49530.0 51950.7 55437.7 55825.0 8102.7 8332.5 8448.6 8505.5 8549.6 12285.8 13046.2 13193.6 13216.3 13328.6 11573.7 11715.5 11734.5 11808.4 12160.3 11023.7 11265.8 11309.4 11428.5 11480.4 11157.4 11932.9 11981.5 12048.6 12302.4 8069.4 8284.8 8324.3 8423.7 8489.3 11732.5 11983.5 12005.6 12144.6 12239.8 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | [#3] mootools.html Cycles:180 Average:5315.92 Median:6425.92 stddev:2758.61 (42.9%) stddev-sans-first:2750.30 20:41:34 INFO - PROCESS | 21798 | Values: 1358.3 1463.2 1478.8 1641.3 1791.6 7191.7 7374.9 7386.6 7393.8 7394.7 7281.6 7412.7 7413.2 7417.7 7420.8 1874.4 2185.5 2229.4 2231.5 2248.1 2173.5 2181.1 2181.7 2186.4 2187.0 2125.4 2236.8 2238.5 2240.1 2240.8 2171.3 2204.7 2212.2 2213.7 2216.3 2198.9 2206.0 2212.4 2214.6 2230.8 7439.2 7556.7 7561.3 7564.9 7565.4 4583.6 4677.0 4682.6 4688.1 4688.9 2918.8 3002.4 3002.8 3040.3 3073.3 992.8 999.0 1006.4 1023.7 1027.8 10221.4 10230.1 10244.3 10256.3 10268.6 4000.0 4101.0 4136.6 4204.3 4212.1 8854.7 8871.2 8882.1 8885.9 8893.6 4103.1 4723.8 4729.9 4738.4 4740.9 4235.9 4279.0 4286.1 4306.7 4332.6 3563.6 3616.6 3650.0 3674.6 3702.8 1168.9 1169.6 1172.3 1175.5 1178.6 1113.4 1122.1 1253.2 1380.5 1387.8 7210.1 7268.1 7366.8 7416.5 7424.9 448.6 449.4 449.9 452.0 468.5 5679.5 5729.3 5733.2 5754.5 5789.9 8673.2 8865.9 9220.8 9227.9 9231.5 9084.4 9099.8 9120.6 9137.1 9168.3 7134.6 7149.8 7200.2 7225.5 7227.2 7038.4 7065.9 7067.8 7071.8 7091.9 8118.9 8303.9 8313.3 8420.2 8464.0 8170.8 8218.3 8234.4 8342.6 8373.1 6641.5 6730.6 6822.8 6825.2 6827.2 7144.4 7147.0 7172.3 7177.8 7181.1 6455.6 6665.5 6738.3 6772.1 6773.7 6616.3 6671.2 6700.9 6723.7 6795.1 6891.4 6926.3 6979.9 6982.3 6989.5 6395.6 6410.4 6441.4 6445.1 6454.0 6407.2 6442.5 6454.0 6459.6 6474.8 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | [#4] prototype.html Cycles:180 Average:5237.17 Median:6053.21 stddev:1575.70 (26.0%) stddev-sans-first:1536.40 20:41:34 INFO - PROCESS | 21798 | Values: 326.1 326.9 328.1 333.3 341.4 5848.5 5866.9 5904.7 5914.9 5917.4 5787.5 5792.3 5793.7 5804.2 5805.7 4327.9 4484.3 4522.3 4552.8 4592.3 4575.4 4580.3 4591.4 4598.8 4604.7 4537.2 4541.9 4545.5 4548.4 4559.5 4254.1 4447.9 4494.7 4532.8 4534.5 3998.8 4003.2 4010.9 4012.6 4019.6 5705.5 5716.5 5717.1 5717.2 5721.1 5298.8 5301.5 5309.7 5310.7 5313.2 6226.4 6257.0 6257.9 6268.8 6274.8 4219.6 4350.9 4361.4 4462.4 4466.1 6463.5 6496.4 6512.1 6531.2 6531.2 4438.7 4446.6 4446.6 4449.6 4453.5 4505.9 4508.9 4510.5 4513.0 4514.5 5214.0 5219.5 5222.2 5223.0 5230.9 6161.3 6305.4 6307.4 6318.9 6322.7 1551.7 1554.3 1562.0 1562.0 1563.5 957.8 984.7 1004.7 1035.5 1048.6 6029.8 6050.3 6091.1 6103.7 6103.9 6448.2 6449.6 6464.6 6466.8 6467.1 6084.9 6094.5 6096.9 6102.0 6103.5 3449.1 3462.1 3467.8 3476.6 3487.5 6608.6 6706.8 6739.8 6746.4 6751.3 6508.7 6550.2 6558.0 6558.4 6559.7 6693.7 6694.8 6710.0 6713.1 6735.3 6364.6 6404.3 6404.6 6412.4 6421.5 6201.0 6303.3 6305.6 6336.1 6350.7 6662.9 6695.5 6700.7 6706.2 6711.3 4462.3 4472.5 4474.0 4479.1 4479.2 6392.1 6414.7 6415.3 6420.7 6422.0 6215.3 6252.4 6252.7 6259.8 6271.2 6059.4 6197.9 6213.2 6223.8 6228.7 6095.9 6110.7 6111.3 6128.9 6132.7 6233.8 6254.6 6264.8 6265.4 6269.8 5968.3 6056.1 6127.6 6128.1 6128.4 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - PROCESS | 21798 | [#5] yui.html Cycles:180 Average:14484.52 Median:25138.61 stddev:16597.75 (66.0%) stddev-sans-first:16612.14 20:41:34 INFO - PROCESS | 21798 | Values: 725.0 786.8 827.7 830.3 858.6 13918.7 14026.8 14038.2 14092.7 14120.7 12221.4 13586.4 13615.1 13686.5 13719.4 797.2 809.6 812.8 813.0 814.5 807.9 808.1 808.3 809.7 815.3 849.3 850.4 852.1 853.1 862.5 847.3 847.4 849.7 850.5 853.0 623.2 623.8 623.9 624.3 624.6 13056.5 13082.3 13091.9 13100.7 13137.2 12220.5 12242.5 12366.3 12460.9 12658.2 10477.8 10708.0 10871.1 10985.3 11072.0 3794.9 4397.6 4459.9 4639.9 4641.1 46471.0 48952.0 49364.5 51247.7 53767.5 10602.2 10786.9 10850.7 11171.9 11203.8 18472.3 18514.1 18520.4 18530.2 18561.0 8162.4 8170.3 8283.2 8301.5 8655.5 4742.3 4788.0 4840.7 4900.3 5069.9 3073.7 3120.5 3163.9 3165.1 3166.8 562.2 579.6 581.9 582.9 585.6 543.5 600.6 610.3 692.9 720.9 8455.8 8644.0 8863.4 8952.3 8982.6 571.9 607.3 637.1 638.3 658.0 3956.7 4071.9 4079.2 4165.3 4296.9 59104.4 59155.7 59319.0 59644.0 59671.1 52440.0 53421.2 53891.7 54516.0 54797.7 41730.0 44423.3 48781.8 50000.0 52815.2 9253.2 9453.5 9455.6 9524.8 9527.0 36848.4 36909.6 37653.6 37968.0 38231.0 45637.3 46891.8 46957.5 47658.8 48126.3 11367.0 11550.9 11560.2 11590.6 11664.8 12528.9 12598.4 12653.7 12707.3 12830.1 12944.1 12944.5 12966.2 12987.3 12991.2 12146.4 12489.6 12561.3 12626.6 12922.5 12006.7 12230.0 12706.2 12931.7 13212.1 10269.8 10303.2 10333.3 10349.0 10609.4 10533.5 10582.2 10653.7 10700.8 10840.4 20:41:34 INFO - PROCESS | 21798 | -------- Summary: end -------- 20:41:34 INFO - PROCESS | 21798 | 20:41:34 INFO - TEST-INFO | 21798: exit 0 20:41:34 INFO - TEST-OK | dromaeo_css | took 1110076ms 20:41:34 INFO - TEST-START | kraken 20:41:34 INFO - operating with platform_type : linux_ 20:41:34 INFO - Initialising browser for kraken test... 20:41:34 INFO - TEST-INFO | started process 21980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYYJG_H/profile http://localhost:36694/getInfo.html) 20:41:38 INFO - PROCESS | 21980 | __metrics Screen width/height:1600/1200 20:41:38 INFO - PROCESS | 21980 | colorDepth:24 20:41:38 INFO - PROCESS | 21980 | Browser inner width/height: 1024/697 20:41:38 INFO - PROCESS | 21980 | __metrics 20:41:39 ERROR - PROCESS | 21980 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:41:39 INFO - PROCESS | 21980 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:41:40 INFO - TEST-INFO | 21980: exit 0 20:41:40 INFO - Browser initialized. 20:41:40 INFO - Running cycle 1/1 for kraken test... 20:41:40 INFO - TEST-INFO | started process 22062 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYYJG_H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:41:51 INFO - PROCESS | 22062 | RSS: Main: 153755648 20:41:51 INFO - PROCESS | 22062 | 20:41:54 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36694/tests/kraken/driver.html?testName=audio-beat-detection) 20:41:54 INFO - PROCESS | 22062 | RSS: Main: 195440640 20:41:54 INFO - PROCESS | 22062 | 20:41:57 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36694/tests/kraken/driver.html?testName=audio-dft) 20:41:58 INFO - PROCESS | 22062 | RSS: Main: 184651776 20:41:58 INFO - PROCESS | 22062 | 20:42:01 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36694/tests/kraken/driver.html?testName=audio-fft) 20:42:01 INFO - PROCESS | 22062 | RSS: Main: 168521728 20:42:01 INFO - PROCESS | 22062 | 20:42:03 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36694/tests/kraken/driver.html?testName=audio-oscillator) 20:42:04 INFO - PROCESS | 22062 | RSS: Main: 171667456 20:42:04 INFO - PROCESS | 22062 | 20:42:06 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:42:07 INFO - PROCESS | 22062 | RSS: Main: 173023232 20:42:07 INFO - PROCESS | 22062 | 20:42:10 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36694/tests/kraken/driver.html?testName=imaging-darkroom) 20:42:10 INFO - PROCESS | 22062 | RSS: Main: 173858816 20:42:10 INFO - PROCESS | 22062 | 20:42:14 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36694/tests/kraken/driver.html?testName=imaging-desaturate) 20:42:14 INFO - PROCESS | 22062 | RSS: Main: 173371392 20:42:14 INFO - PROCESS | 22062 | 20:42:17 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36694/tests/kraken/driver.html?testName=json-parse-financial) 20:42:17 INFO - PROCESS | 22062 | RSS: Main: 174075904 20:42:17 INFO - PROCESS | 22062 | 20:42:19 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:42:20 INFO - PROCESS | 22062 | RSS: Main: 184221696 20:42:20 INFO - PROCESS | 22062 | 20:42:21 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:42:22 INFO - PROCESS | 22062 | RSS: Main: 181198848 20:42:22 INFO - PROCESS | 22062 | 20:42:24 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:42:24 INFO - PROCESS | 22062 | RSS: Main: 193540096 20:42:24 INFO - PROCESS | 22062 | 20:42:27 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:42:27 INFO - PROCESS | 22062 | RSS: Main: 201875456 20:42:27 INFO - PROCESS | 22062 | 20:42:30 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:42:31 INFO - PROCESS | 22062 | RSS: Main: 201601024 20:42:31 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | Cycle 1(1): loaded http://localhost:36694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36694/tests/kraken/driver.html?testName=ai-astar) 20:42:32 INFO - PROCESS | 22062 | RSS: Main: 263532544 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | __start_tp_report 20:42:32 INFO - PROCESS | 22062 | _x_x_mozilla_page_load 20:42:32 INFO - PROCESS | 22062 | _x_x_mozilla_page_load_details 20:42:32 INFO - PROCESS | 22062 | |i|pagename|runs| 20:42:32 INFO - PROCESS | 22062 | |0;ai-astar;111;111;106;112;110;111;100;111;111;109 20:42:32 INFO - PROCESS | 22062 | |1;audio-beat-detection;154;125;154;176;126;153;153;134;181;127 20:42:32 INFO - PROCESS | 22062 | |2;audio-dft;162;161;160;160;160;160;160;163;162;161 20:42:32 INFO - PROCESS | 22062 | |3;audio-fft;76;73;133;106;73;72;74;146;100;73 20:42:32 INFO - PROCESS | 22062 | |4;audio-oscillator;93;93;147;93;93;94;144;93;93;141 20:42:32 INFO - PROCESS | 22062 | |5;imaging-gaussian-blur;117;117;117;124;118;116;117;117;117;117 20:42:32 INFO - PROCESS | 22062 | |6;imaging-darkroom;146;146;145;146;145;146;146;146;147;146 20:42:32 INFO - PROCESS | 22062 | |7;imaging-desaturate;95;95;97;95;95;95;95;95;95;95 20:42:32 INFO - PROCESS | 22062 | |8;json-parse-financial;56;57;55;56;58;58;59;66;53;54 20:42:32 INFO - PROCESS | 22062 | |9;json-stringify-tinderbox;60;61;60;60;61;61;60;61;61;61 20:42:32 INFO - PROCESS | 22062 | |10;stanford-crypto-aes;78;80;80;77;78;78;79;78;78;78 20:42:32 INFO - PROCESS | 22062 | |11;stanford-crypto-ccm;122;117;109;119;117;111;122;111;112;111 20:42:32 INFO - PROCESS | 22062 | |12;stanford-crypto-pbkdf2;144;136;143;145;144;135;149;142;141;147 20:42:32 INFO - PROCESS | 22062 | |13;stanford-crypto-sha256-iterative;66;64;64;66;65;65;63;63;69;62 20:42:32 INFO - PROCESS | 22062 | __end_tp_report 20:42:32 INFO - PROCESS | 22062 | __start_cc_report 20:42:32 INFO - PROCESS | 22062 | _x_x_mozilla_cycle_collect,1084 20:42:32 INFO - PROCESS | 22062 | __end_cc_report 20:42:32 INFO - PROCESS | 22062 | __startTimestamp1458963752922__endTimestamp 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | ------- Summary: start ------- 20:42:32 INFO - PROCESS | 22062 | Number of tests: 14 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:3.81 20:42:32 INFO - PROCESS | 22062 | Values: 111.0 111.0 106.0 112.0 110.0 111.0 100.0 111.0 111.0 109.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.50 stddev:20.12 (13.1%) stddev-sans-first:21.24 20:42:32 INFO - PROCESS | 22062 | Values: 154.0 125.0 154.0 176.0 126.0 153.0 153.0 134.0 181.0 127.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 20:42:32 INFO - PROCESS | 22062 | Values: 162.0 161.0 160.0 160.0 160.0 160.0 160.0 163.0 162.0 161.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#3] audio-fft Cycles:10 Average:92.60 Median:73.00 stddev:27.72 (38.0%) stddev-sans-first:28.75 20:42:32 INFO - PROCESS | 22062 | Values: 76.0 73.0 133.0 106.0 73.0 72.0 74.0 146.0 100.0 73.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.61 (26.5%) stddev-sans-first:25.46 20:42:32 INFO - PROCESS | 22062 | Values: 93.0 93.0 147.0 93.0 93.0 94.0 144.0 93.0 93.0 141.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:2.26 (1.9%) stddev-sans-first:2.39 20:42:32 INFO - PROCESS | 22062 | Values: 117.0 117.0 117.0 124.0 118.0 116.0 117.0 117.0 117.0 117.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:42:32 INFO - PROCESS | 22062 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:42:32 INFO - PROCESS | 22062 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:3.61 (6.3%) stddev-sans-first:3.81 20:42:32 INFO - PROCESS | 22062 | Values: 56.0 57.0 55.0 56.0 58.0 58.0 59.0 66.0 53.0 54.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 20:42:32 INFO - PROCESS | 22062 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 20:42:32 INFO - PROCESS | 22062 | Values: 78.0 80.0 80.0 77.0 78.0 78.0 79.0 78.0 78.0 78.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#11] stanford-crypto-ccm Cycles:10 Average:115.10 Median:117.00 stddev:4.89 (4.2%) stddev-sans-first:4.50 20:42:32 INFO - PROCESS | 22062 | Values: 122.0 117.0 109.0 119.0 117.0 111.0 122.0 111.0 112.0 111.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:144.00 stddev:4.40 (3.1%) stddev-sans-first:4.64 20:42:32 INFO - PROCESS | 22062 | Values: 144.0 136.0 143.0 145.0 144.0 135.0 149.0 142.0 141.0 147.0 20:42:32 INFO - PROCESS | 22062 | 20:42:32 INFO - PROCESS | 22062 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:2.00 (3.1%) stddev-sans-first:2.07 20:42:32 INFO - PROCESS | 22062 | Values: 66.0 64.0 64.0 66.0 65.0 65.0 63.0 63.0 69.0 62.0 20:42:32 INFO - PROCESS | 22062 | -------- Summary: end -------- 20:42:32 INFO - PROCESS | 22062 | 20:42:33 INFO - TEST-INFO | 22062: exit 0 20:42:33 INFO - TEST-OK | kraken | took 58992ms 20:42:33 INFO - SUITE-END | took 1169s 20:42:34 INFO - Completed test suite (00:19:29) 20:42:34 INFO - javascript benchmark 20:42:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2987.7609791216705, 3045.7411120054794, 3056.465118604244, 3085.1207405889327, 3114.6106736657925, 5012.047710934919, 5126.41046279678, 5169.1987741899975, 5189.974050129754, 5220.060389129955, 5213.296205012322, 5231.24146998685, 5232.3459567554055, 5235.633505654596, 5306.177542480922, 4675.368825208604, 4706.647001474895, 4744.169770290203, 4777.235642297233, 4810.615150787946, 4556.9088618227615, 4750.16872047392, 4796.952030479702, 4816.494268101851, 4817.349657796188, 4740.19416699162, 4760.238361862085, 4763.857084287442, 4766.3088852116425, 4818.277258411232, 4727.101850648366, 4728.148933192024, 4744.881377965544, 4749.548792864673, 4786.090642777861, 4551.135284296006, 4663.813447462131, 4703.15343238217, 4710.717356958594, 4753.3582966299455, 5149.76826042829, 5178.223266510016, 5180.119379705459, 5182.352205974254, 5191.351081114861, 5534.1975413564805, 5551.278333816578, 5551.861203469905, 5568.220449137084, 5613.0, 5489.945100548984, 5589.049861523551, 5635.49280564747, 5716.57125715573, 5722.656640601535, 5093.108705976476, 5094.1849304111165, 5095.31213286209, 5103.464136265676, 5112.3865136183895, 5577.0, 5577.470140336662, 5579.107342825128, 5579.497845193952, 5586.273784408001, 5377.300950876439, 5438.184272359178, 5468.671879687152, 5516.034693928546, 5535.778568857281, 5583.944160558342, 5598.552115830724, 5602.2717046783655, 5602.52378547828, 5604.243427137284, 5269.657472264291, 5588.692621905834, 5603.7173174283835, 5607.102863541813, 5607.43925607436, 5617.0, 5653.0, 5658.122990936329, 5662.660240385508, 5704.543636509069, 4213.0310028693575, 4222.4299719538085, 4235.8729238122905, 4236.216299984513, 4275.40144379787, 3721.1813401051727, 3770.170562476251, 3802.524684414448, 3811.1424929390664, 3839.4432807242792, 5268.868278293074, 5292.52367286946, 5296.814611488579, 5324.840254792362, 5349.839504814861, 5572.58205634579, 5596.664200148004, 5599.832005039855, 5601.29983752031, 5603.691796951207, 5175.094358487249, 5202.193659982633, 5299.867503312448, 5313.920291195635, 5362.302900622894, 4850.539198776181, 4856.368672072608, 4866.853994380174, 4879.902401951941, 4896.4858689837765, 5805.912911306334, 5808.157817116579, 5811.738471768781, 5814.738336774855, 5833.38749431312, 5519.116941289535, 5593.888122237614, 5611.3266408031295, 5701.344345400166, 5720.6853623049465, 5765.1928729977, 5794.884102318014, 5796.159556864315, 5799.565032622654, 5800.4489573490455, 5467.835964921059, 5475.370332411664, 5475.370332411823, 5478.671279723229, 5481.342238931354, 5425.294711687456, 5530.059889818821, 5581.665100094007, 5592.916106258491, 5627.296587926509, 5392.05639013179, 5400.9459905400445, 5402.378726446509, 5413.53984911287, 5421.484958928895, 5241.449647786927, 5386.057439947915, 5386.326709161355, 5386.326709161355, 5441.0, 5411.648242864201, 5458.099413596712, 5478.0, 5482.23248745168, 5521.171824226398, 5524.171374293888, 5534.501894829485, 5558.666480011212, 5570.053090974625, 5574.414686457863, 5204.2714020036465, 5324.866878328073, 5426.348838139448, 5451.945480545302, 5496.065668836228], "unit": "score", "name": "dojo.html", "value": 5140.69184945136}, {"lowerIsBetter": false, "replicates": [556.7241689215779, 577.5639392258846, 579.1602176843577, 593.631948192121, 596.3410431473224, 29652.258693532673, 30036.249093772665, 37864.242715145716, 38113.237735245275, 38318.808405958, 41251.38122928151, 41328.79335603325, 41851.581484185146, 41853.58146418535, 41878.16243675125, 8780.297576193905, 8995.280377569812, 8995.550222488882, 8999.820003599923, 9004.639814407416, 8647.65409383627, 8737.868931966026, 8744.737657870273, 8745.0, 8751.649934002633, 8773.166549177819, 8812.647494100229, 8849.95575022124, 8870.93548774148, 8881.111888811132, 8753.7811554711, 8779.473231606124, 8843.380963332569, 8851.513166775825, 8864.0692727264, 8760.12398760119, 8881.023087460375, 8887.644494220289, 8891.688790892353, 8897.777555561099, 40941.1811763766, 41087.58912410867, 41113.0, 41168.38247426291, 41174.38238426396, 3330.7834990725523, 3497.5278337424375, 4092.3247664135383, 4151.3150330195485, 4266.552012038722, 30847.845760771277, 30896.691033089606, 31028.37943241145, 31084.067477975696, 32666.183345416317, 4320.9135817283795, 4336.91326173478, 4366.737995720236, 4500.167469018242, 4593.747343896118, 297972.0, 300323.0, 301606.0, 301937.0, 302032.0, 53114.46885531095, 58997.705011475526, 59126.0, 60376.094358584654, 61749.073763893575, 55952.0, 55999.440005600234, 56146.0, 56359.43640563624, 56374.0, 15283.46507872219, 15418.537443876701, 15421.151836648867, 15436.15101169424, 15450.459233926758, 11528.193026488065, 12596.496140154475, 12825.679358015937, 12978.870211297766, 12980.870191298154, 18900.338488152847, 18953.526161846064, 19020.809791902182, 19087.0, 19139.2344306229, 6774.356436138559, 6991.825204369931, 7138.107736532934, 7319.268073192638, 7319.707211711579, 1013.3970287678819, 1033.720895358249, 1107.7950579142885, 1151.1251448898897, 1179.6520026592175, 31650.0, 31798.364032719215, 31889.362212755615, 31971.200719982186, 32365.676343236737, 1043.6555936540924, 1097.1497089755503, 1098.5386137822134, 1161.866385365677, 1162.7558212775243, 15777.763333550007, 16386.180690965404, 16515.58711032234, 16587.502374928772, 16745.246463909152, 373479.0, 381646.0, 381657.0, 382385.0, 382812.0, 55571.0, 55816.441835581936, 56244.43755562474, 56248.71875640677, 56267.43732562704, 1273.757985982679, 1292.702678383977, 1400.6078298076352, 1423.978640320396, 1430.29915341484, 27759.861200693867, 29245.85377073101, 29527.0, 29746.702532975258, 29869.70130298756, 41272.0, 41471.7926410366, 41639.583604164785, 41735.373969389875, 41796.16407671769, 244600.0, 245494.0, 250687.0, 250985.0, 251690.0, 30325.545116822825, 30953.535696964114, 33226.0, 33466.16334591557, 34031.0, 40772.1845563093, 40860.59139408568, 41177.0, 41447.792761037206, 41605.58394416017, 35577.64422355847, 37479.0, 38330.0417489565, 38896.80551597224, 39182.412263815495, 37052.41204657681, 37072.25855482929, 37907.0, 38260.42609360806, 38705.6129438702, 37837.24325513419, 37982.62017379901, 39752.204955901296, 40658.390124148755, 40737.59262407338, 30255.848720757134, 31686.524702129947, 32232.677673223905, 32310.515342269413, 32459.837700811346, 25041.74958250394, 25447.745522544537, 25481.745182547937, 25533.744662553137, 25838.354041149123], "unit": "score", "name": "ext.html", "value": 18897.82117198869}, {"lowerIsBetter": false, "replicates": [366.32961680125374, 371.5448575495019, 374.3841380928375, 378.9588551871233, 382.33282921302333, 17391.0, 18135.183916723745, 18257.269709211614, 18571.90714046428, 18616.25534978599, 16791.83208167918, 17028.659426811457, 17662.0, 17686.823131768677, 17687.204075816586, 5523.7790488380515, 5679.971600141994, 5706.201131841545, 5717.8570535736735, 5721.113227449731, 4133.090720041586, 5594.49649531542, 5993.700314984255, 6247.500199983991, 6273.435390814826, 6195.5663103582765, 6205.596636218654, 6217.471514921237, 6225.190725205717, 6227.719752611143, 5952.345242023374, 6140.201773769426, 6141.877162456748, 6144.784932527385, 6150.077488376757, 3767.2465506898457, 5177.948220517822, 5395.082835917903, 5399.163129714901, 5410.404855465896, 20074.0, 20161.596768064555, 20276.898615506827, 21665.241716540004, 21684.132634694593, 2256.9210077647203, 2285.6800047993293, 2453.1046168148678, 2459.6433517140094, 2498.088197807787, 7064.576125432491, 7156.069710937597, 7944.523328600302, 13516.864831351659, 13674.49580546139, 1899.3627203904507, 1962.4505138561226, 2024.9493762655904, 2112.207922029239, 2115.312523429876, 71141.0, 71395.64302178456, 72018.63990680066, 73142.63428682876, 73953.0, 10080.74798130038, 10294.0, 10381.688549343531, 10408.843867341995, 10520.894791052144, 14564.49024284145, 14658.706825863423, 14689.92655036718, 14692.92653536747, 14696.779548306784, 7591.734289299848, 7841.0, 7919.762407127795, 7969.72105976288, 8014.479058861155, 7538.811529711801, 7592.81017974555, 7665.770026899202, 7667.472962437229, 7677.539347639159, 4479.574440428154, 4492.550744925481, 4492.595666390041, 4510.782088835996, 4608.0, 1740.617064245864, 1806.1420825107969, 3095.4582947984013, 3172.5241213818113, 3216.7748257621743, 903.2457897655531, 937.9437233765996, 952.7284723853669, 957.7174733453647, 1052.5263631365915, 16908.661826763397, 17327.826721732872, 18133.90933045326, 18285.354318111433, 18759.90620046891, 994.572333896417, 1023.7542989682422, 1028.2339656955617, 1038.2991480750463, 1040.7086015915556, 8953.910460895308, 10427.530761115768, 10432.321899076536, 10436.478176091317, 10478.117028061333, 536534.0, 539280.0, 546838.0, 553656.0, 553889.0, 85977.5701121503, 86516.0, 87304.56347718221, 89841.0, 90475.54762226147, 1008.2841182760322, 1009.2632378363688, 1011.9949400252951, 1032.194887987371, 1036.4558606731525, 16120.67758644844, 16240.0, 16265.43070992557, 16355.182240888145, 16547.089910055063, 36947.815260923526, 37573.43639845459, 38647.6135238644, 38924.80537597294, 38939.221215574966, 49154.0, 49530.0, 51950.74024629853, 55437.7228113873, 55825.0, 8102.675892964216, 8332.458390204618, 8448.619812108593, 8505.532195729294, 8549.572521373782, 12285.815712764137, 13046.217226966412, 13193.604191873876, 13216.339183040618, 13328.600141995756, 11573.710657233636, 11715.472803723682, 11734.471948762155, 11808.35054072, 12160.270383777002, 11023.669289921316, 11265.7746845061, 11309.377984210947, 11428.48571814287, 11480.425978700865, 11157.386343751172, 11932.940335298616, 11981.460834262654, 12048.578299759467, 12302.446389912655, 8069.435139540175, 8284.83430331402, 8324.292435143081, 8423.70517031901, 8489.278411335106, 11732.530698771954, 11983.460744266704, 12005.63983080509, 12144.574939877062, 12239.75520489603], "unit": "score", "name": "jquery.html", "value": 9051.25496880862}, {"lowerIsBetter": false, "replicates": [1358.300475255243, 1463.246428089534, 1478.8151481064865, 1641.2778377513894, 1791.578978939948, 7191.748288809893, 7374.926250737498, 7386.593737344444, 7393.7781866543955, 7394.667239974201, 7281.635918204095, 7412.703491860319, 7413.221611730772, 7417.666205020773, 7420.777376678709, 1874.3814541201439, 2185.4536365908525, 2229.398062523122, 2231.520223152022, 2248.1119957616734, 2173.4892300309416, 2181.0730439563204, 2181.6727490876337, 2186.4424571734266, 2187.004912764696, 2125.3730149605904, 2236.8434209605334, 2238.4963383238724, 2240.0815665577115, 2240.7535171131244, 2171.283476452767, 2204.7023651806962, 2212.236778311496, 2213.690083388327, 2216.3018649125474, 2198.9450263743533, 2205.9558808823895, 2212.3805334506364, 2214.579229946305, 2230.810381117607, 7439.181690014094, 7556.7355142570295, 7561.281678240558, 7564.886526702104, 7565.35694465971, 4583.610393116589, 4677.0178262564905, 4682.555157260055, 4688.062387522509, 4688.906221875543, 2918.7664986801005, 3002.384511175204, 3002.8348440835744, 3040.2703351195773, 3073.339232065094, 992.811365840488, 998.975025624358, 1006.3710181136789, 1023.728711891342, 1027.7584767579613, 10221.437820919771, 10230.130438912702, 10244.28290019699, 10256.333338332985, 10268.640597579124, 4000.0399904022825, 4100.979495102565, 4136.607022332873, 4204.26425375558, 4212.094399704017, 8854.690085846965, 8871.245944094695, 8882.0673829247, 8885.866711999326, 8893.599788009426, 4103.056297051695, 4723.811047558128, 4729.929051064237, 4738.407699037621, 4740.857774266778, 4235.894102647459, 4278.978605106954, 4286.121345124242, 4306.720063195882, 4332.610065094157, 3563.6080031196548, 3616.6021737608844, 3650.0, 3674.559052913614, 3702.7593206441493, 1168.9123315751353, 1169.6432588060723, 1172.267332916927, 1175.5474142455216, 1178.6464060781732, 1113.3542545323692, 1122.085500317239, 1253.2104773992326, 1380.5444203412849, 1387.833459984788, 7210.134783825974, 7268.127824660969, 7366.815829604303, 7416.480846340704, 7424.888626670604, 448.6253977928401, 449.43146919146653, 449.94150760400936, 452.01460815422035, 468.51274674338987, 5679.460451257124, 5729.25519682447, 5733.226014487991, 5754.482096611325, 5789.855253618609, 8673.219410253107, 8865.911340886509, 9220.769480763034, 9227.86158207614, 9231.538423078953, 9084.40951338161, 9099.772505687411, 9120.635174593075, 9137.08629137081, 9168.312376571785, 7134.571925684476, 7149.785506434815, 7200.243974382719, 7225.530340527849, 7227.241139680468, 7038.436925046087, 7065.929340706527, 7067.752628657972, 7071.82320441993, 7091.9290807091265, 8118.9188108120525, 8303.875441868257, 8313.33493320545, 8420.200080992296, 8464.026636936831, 8170.754877353689, 8218.260356567938, 8234.423590348619, 8342.582870856311, 8373.078961314372, 6641.501887358564, 6730.596164230162, 6822.829429264109, 6825.215100263533, 6827.249002609609, 7144.3570078693165, 7146.964265178641, 7172.318629730167, 7177.784666460015, 7181.138263408425, 6455.61266324022, 6665.533412661067, 6738.292479289604, 6772.085768421397, 6773.6951837168435, 6616.338366163345, 6671.166104236971, 6700.899486507608, 6723.731050757915, 6795.116634837439, 6891.448684105159, 6926.307369263235, 6979.860402792017, 6982.266861979622, 6989.47578931572, 6395.552311338161, 6410.423061924449, 6441.420272175526, 6445.097686323825, 6453.967730161319, 6407.199100112486, 6442.452391546771, 6454.031895215755, 6459.580127291711, 6474.805755827333], "unit": "score", "name": "mootools.html", "value": 4297.553945511413}, {"lowerIsBetter": false, "replicates": [326.0837047895414, 326.8676186144611, 328.1075474708793, 333.2684756958474, 341.43322085338343, 5848.4736373726355, 5866.882662346756, 5904.734286957087, 5914.85212869678, 5917.408259174075, 5787.536997040237, 5792.275965504312, 5793.681347525895, 5804.158397032428, 5805.680687562182, 4327.891802704926, 4484.282514797633, 4522.344260082286, 4552.817887284521, 4592.334111553822, 4575.38232338635, 4580.290055041457, 4591.44902611687, 4598.816047358118, 4604.6776725629215, 4537.2286711259, 4541.909161816761, 4545.499995000564, 4548.363229147922, 4559.452865656126, 4254.064105896698, 4447.911041779179, 4494.70784399013, 4532.773361331921, 4534.523874993111, 3998.7600743955454, 4003.219372222418, 4010.8796736097966, 4012.6388625023596, 4019.577944315834, 5705.486506214419, 5716.542676585905, 5717.113847353667, 5717.170505438261, 5721.113227449752, 5298.841034768963, 5301.469853014706, 5309.734513274321, 5310.654807437504, 5313.203019547061, 6226.40849119333, 6257.0, 6257.8748425031245, 6268.840264551072, 6274.811755647338, 4219.556946520602, 4350.8912277193, 4361.367601697768, 4462.3975763271865, 4466.12910482456, 6463.482921366326, 6496.415322620986, 6512.055751915993, 6531.24890637578, 6531.24890637578, 4438.667099967515, 4446.555344465528, 4446.577575130357, 4449.621782148489, 4453.51011388747, 4505.932411013838, 4508.864734057984, 4510.458744950562, 4513.029698614813, 4514.458265008155, 5213.973930130325, 5219.5041471060185, 5222.164453687392, 5223.033738758342, 5230.947690523122, 6161.291451483136, 6305.4009869062365, 6307.369263073656, 6318.905216421757, 6322.747090116436, 1551.6586351002761, 1554.2772610736063, 1561.960950976212, 1562.0315404449314, 1563.499680102379, 957.7940742740344, 984.7045886234245, 1004.7387679203459, 1035.53400969564, 1048.6067724603274, 6029.758809647565, 6050.334463209044, 6091.116788065706, 6103.694815259308, 6103.877922441615, 6448.226212854393, 6449.613023218528, 6464.612123272619, 6466.773662921775, 6467.062275969958, 6084.9351363511205, 6094.542909281821, 6096.908546371808, 6102.0, 6103.542234332443, 3449.085992212066, 3462.1344663834043, 3467.8439470223902, 3476.5828100628087, 3487.511748355232, 6608.570442921195, 6706.765263215764, 6739.764108256188, 6746.392824645805, 6751.291114433012, 6508.707108180143, 6550.213974323112, 6558.016297555405, 6558.409743123142, 6559.672016399257, 6693.665316734144, 6694.765683201064, 6710.027046078291, 6713.0937323461685, 6735.259121496631, 6364.64994425311, 6404.295527491879, 6404.647744374104, 6412.422881940648, 6421.486281097595, 6200.968995154995, 6303.338149494237, 6305.5901366411035, 6336.112944187726, 6350.682465876595, 6662.900056499253, 6695.4978376620975, 6700.731970721116, 6706.161729783777, 6711.261761206166, 4462.308342206963, 4472.530384309731, 4473.977630111829, 4479.104179164115, 4479.17135329965, 6392.137061496638, 6414.743410263537, 6415.3263907289065, 6420.7431702731365, 6422.036694495863, 6215.316315205414, 6252.437280644764, 6252.749890004531, 6259.812205633838, 6271.247450305992, 6059.394060593905, 6197.876042479035, 6213.1922850029205, 6223.782167624111, 6228.657423841551, 6095.908561371494, 6110.663913484623, 6111.297200821962, 6128.908066378919, 6132.724027418866, 6233.750649974132, 6254.562180647493, 6264.812055638338, 6265.404786545453, 6269.843253918689, 5968.283805943314, 6056.091586262096, 6127.601705889103, 6128.111423843607, 6128.417800308964], "unit": "score", "name": "prototype.html", "value": 4718.343865347914}, {"lowerIsBetter": false, "replicates": [724.9891251631224, 786.7797016835286, 827.7185756842672, 830.2610676497922, 858.6393714639851, 13918.721625567483, 14026.789598156036, 14038.157710537374, 14092.718145637094, 14120.717585648294, 12221.38893055346, 13586.388612512435, 13615.115017523854, 13686.452541898338, 13719.382627781748, 797.1669605262515, 809.6073404398862, 812.8414959082982, 813.0446725097986, 814.4543156085407, 807.9012542941595, 808.0908977400425, 808.2564041082219, 809.6963638635511, 815.339574944297, 849.2993280543545, 850.4344610833788, 852.1435956863374, 853.0744142605281, 862.5169904853271, 847.3306088190322, 847.3898792869124, 849.668629234599, 850.4557083466586, 852.9914700853005, 623.2303105664546, 623.7504998000836, 623.8596315828947, 624.3007831229053, 624.5908929651085, 13056.477740890354, 13082.345882705828, 13091.869081309256, 13100.737985240241, 13137.211767293993, 12220.450079746433, 12242.510299588006, 12366.258024518467, 12460.937695311555, 12658.240505569604, 10477.790444191074, 10708.0, 10871.130309575216, 10985.340879547173, 11072.0, 3794.943075853837, 4397.5602439756085, 4459.866204013852, 4639.907201855977, 4641.141388843041, 46471.0, 48952.0, 49364.50635493635, 51247.74376128095, 53767.46232537625, 10602.151827853753, 10786.94606526978, 10850.72873178161, 11171.94414027941, 11203.775924481464, 18472.261109555737, 18514.074296285402, 18520.351787687367, 18530.16614252362, 18561.0, 8162.3878209134555, 8170.264676179054, 8283.213094755989, 8301.543415112106, 8655.523946182895, 4742.288656701522, 4787.952120478821, 4840.709557426566, 4900.338454308623, 5069.949300506948, 3073.6772638873044, 3120.5163199704084, 3163.8892638757534, 3165.082126183427, 3166.794158379744, 562.1511517608441, 579.5913880714087, 581.8516278348994, 582.8892510423007, 585.5520526797004, 543.4646872830259, 600.6006006005957, 610.2768219659717, 692.8614277144491, 720.9387202087777, 8455.830883382298, 8643.956780216058, 8863.379563430626, 8952.328575356874, 8982.640694372152, 571.8570357410647, 607.341034977046, 637.1366797988751, 638.285120664849, 657.9572327798678, 3956.7032472564674, 4071.918561628751, 4079.204555111784, 4165.333546632524, 4296.871093867189, 59104.40895591075, 59155.70422147862, 59319.0, 59644.0, 59671.10493342603, 52440.0, 53421.1986820198, 53891.730541347046, 54516.0, 54797.72601137048, 41730.0, 44423.33364999528, 48781.75609122003, 50000.0, 52815.207771883455, 9253.167214950687, 9453.527323633929, 9455.574499147693, 9524.809503810024, 9526.952365238129, 36848.44727329146, 36909.630903691694, 37653.62346376611, 37968.0, 38231.04422389463, 45637.31544026776, 46891.76554117344, 46957.53042469532, 47658.761706191246, 48126.278105829144, 11367.0, 11550.88449115498, 11560.248583842023, 11590.594329198437, 11664.766704666028, 12528.874711253135, 12598.433070512032, 12653.74692506163, 12707.301098439675, 12830.10189286741, 12944.09391342597, 12944.482220711066, 12966.22202667843, 12987.28569928663, 12991.220526768424, 12146.392680366123, 12489.625311240678, 12561.309127997682, 12626.621201363974, 12922.483100675867, 12006.699832504257, 12230.0, 12706.174098683556, 12931.676708082374, 13212.141210821266, 10269.794604108025, 10303.175745940456, 10333.338328662725, 10348.979530912673, 10609.363438193734, 10533.473326333806, 10582.206334525095, 10653.680389588324, 10700.785984280426, 10840.403777792297], "unit": "score", "name": "yui.html", "value": 6594.992583911992}], "name": "dromaeo_css", "value": 6999.519723154658}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 112.0, 110.0, 111.0, 100.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 154.0, 176.0, 126.0, 153.0, 153.0, 134.0, 181.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 133.0, 106.0, 73.0, 72.0, 74.0, 146.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 92.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 147.0, 93.0, 93.0, 94.0, 144.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 124.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 58.0, 58.0, 59.0, 66.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.6}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 80.0, 77.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.4}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 109.0, 119.0, 117.0, 111.0, 122.0, 111.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.1}, {"lowerIsBetter": true, "replicates": [144.0, 136.0, 143.0, 145.0, 144.0, 135.0, 149.0, 142.0, 141.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 64.0, 66.0, 65.0, 65.0, 63.0, 63.0, 69.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.7}], "name": "kraken", "value": 1496.8}]} 20:42:34 INFO - Return code: 0 20:42:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:42:34 ERROR - # TBPL SUCCESS # 20:42:34 INFO - Running post-action listener: _resource_record_post_action 20:42:34 INFO - Running post-run listener: _resource_record_post_run 20:42:35 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392982528; Read time: 8; Write time: 360432 20:42:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108519424; Read time: 0; Write time: 110400 20:42:35 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280137728; Read time: 8; Write time: 248572 20:42:35 INFO - Running post-run listener: _upload_blobber_files 20:42:35 INFO - Blob upload gear active. 20:42:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:42:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:42:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:42:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:42:35 INFO - (blobuploader) - INFO - Open directory for files ... 20:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:42:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:36 INFO - (blobuploader) - INFO - Done attempting. 20:42:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:42:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:42:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:42:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:42:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:42:37 INFO - (blobuploader) - INFO - Done attempting. 20:42:37 INFO - (blobuploader) - INFO - Iteration through files over. 20:42:38 INFO - Return code: 0 20:42:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:42:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:42:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c08f74dd37a97905412ea645a865bb9fbc6733fad0ede30b9fcc4fde48cc4f504130cdf6f3beb1ff33e74acc809395ddb28aa6497bc728b949e6221974039e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2973a8bd77dbc092a9570aa0f86684ab0135f57504367a4b23c2cbe0f65442825f90a242ea4c19a70402fd99834efcb11db1ab072b92cb19a5e01f987a87cdce"} 20:42:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:42:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:42:38 INFO - Contents: 20:42:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c08f74dd37a97905412ea645a865bb9fbc6733fad0ede30b9fcc4fde48cc4f504130cdf6f3beb1ff33e74acc809395ddb28aa6497bc728b949e6221974039e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2973a8bd77dbc092a9570aa0f86684ab0135f57504367a4b23c2cbe0f65442825f90a242ea4c19a70402fd99834efcb11db1ab072b92cb19a5e01f987a87cdce"} 20:42:38 INFO - Running post-run listener: copy_logs_to_upload_dir 20:42:38 INFO - Copying logs to upload dir... 20:42:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:42:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.678579 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-25 20:42:37.101349) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 20:42:37.104639) ========= 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c08f74dd37a97905412ea645a865bb9fbc6733fad0ede30b9fcc4fde48cc4f504130cdf6f3beb1ff33e74acc809395ddb28aa6497bc728b949e6221974039e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2973a8bd77dbc092a9570aa0f86684ab0135f57504367a4b23c2cbe0f65442825f90a242ea4c19a70402fd99834efcb11db1ab072b92cb19a5e01f987a87cdce"} build_url:https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/TGBC4uO6QoCATD0aVXQG7g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c08f74dd37a97905412ea645a865bb9fbc6733fad0ede30b9fcc4fde48cc4f504130cdf6f3beb1ff33e74acc809395ddb28aa6497bc728b949e6221974039e02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2973a8bd77dbc092a9570aa0f86684ab0135f57504367a4b23c2cbe0f65442825f90a242ea4c19a70402fd99834efcb11db1ab072b92cb19a5e01f987a87cdce"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 20:42:37.154193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:42:37.154518) ========= 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=1b9da9da7504fe468691862d000001b9-1458962322.139289-191059413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 20:42:37.265077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 20:42:37.265404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 20:42:37.265698) ========= ========= Total master_lag: 0.36 =========