builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1458835906.97 results: success (0) buildid: 20160324062348 builduid: 1df69062f8964cb7a794eedb42e1cf00 revision: bf27bbf52e4be36dee46a9fd9fa94187a402f8bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:46.975092) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:46.977078) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:46.977466) ========= 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.053910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.054284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.223812) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.224345) ========= 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.339245) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.339544) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.339902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.340179) ========= 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 09:11:48-- 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% 67.9M=0s 2016-03-24 09:11:48 (67.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.457591 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.836045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.836365) ========= 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017234 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:47.935400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 09:11:47.935748) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf27bbf52e4be36dee46a9fd9fa94187a402f8bc --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf27bbf52e4be36dee46a9fd9fa94187a402f8bc --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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 09:11:48,646 truncating revision to first 12 chars 2016-03-24 09:11:48,646 Setting DEBUG logging. 2016-03-24 09:11:48,647 attempt 1/10 2016-03-24 09:11:48,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf27bbf52e4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 09:11:49,790 unpacking tar archive at: mozilla-aurora-bf27bbf52e4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558937 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 09:11:49.528763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:49.529302) ========= echo bf27bbf52e4be36dee46a9fd9fa94187a402f8bc in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bf27bbf52e4be36dee46a9fd9fa94187a402f8bc'] 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bf27bbf52e4be36dee46a9fd9fa94187a402f8bc program finished with exit code 0 elapsedTime=0.004657 script_repo_revision: 'bf27bbf52e4be36dee46a9fd9fa94187a402f8bc' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:49.615462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:49.615768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 09:11:49.704846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-03-24 09:11:49.705468) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:11:50 INFO - MultiFileLogger online at 20160324 09:11:50 in /builds/slave/test-pgo 09:11:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:11:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:11:50 INFO - {'append_to_log': False, 09:11:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:11:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:11:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:11:50 INFO - 'branch': 'Mozilla-Aurora', 09:11:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:50 INFO - 'config_files': ('talos/linux_config.py',), 09:11:50 INFO - 'default_actions': ('clobber', 09:11:50 INFO - 'read-buildbot-config', 09:11:50 INFO - 'download-and-extract', 09:11:50 INFO - 'populate-webroot', 09:11:50 INFO - 'create-virtualenv', 09:11:50 INFO - 'install', 09:11:50 INFO - 'run-tests'), 09:11:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:50 INFO - 'download_minidump_stackwalk': True, 09:11:50 INFO - 'download_symbols': 'ondemand', 09:11:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:50 INFO - 'installer_path': 'installer.exe', 09:11:50 INFO - 'log_level': 'info', 09:11:50 INFO - 'log_name': 'talos', 09:11:50 INFO - 'log_to_console': True, 09:11:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:11:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:11:50 INFO - 'opt_config_files': (), 09:11:50 INFO - 'pip_index': False, 09:11:50 INFO - 'sps_profile': False, 09:11:50 INFO - 'sps_profile_interval': 0, 09:11:50 INFO - 'suite': 'dromaeojs-e10s', 09:11:50 INFO - 'system_bits': '32', 09:11:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:50 INFO - 'title': 'talos-linux64-ix-059', 09:11:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:50 INFO - 'use_talos_json': True, 09:11:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:11:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:50 INFO - 'work_dir': 'build'} 09:11:50 INFO - ##### 09:11:50 INFO - ##### Running clobber step. 09:11:50 INFO - ##### 09:11:50 INFO - Running pre-action listener: _resource_record_pre_action 09:11:50 INFO - Running main action method: clobber 09:11:50 INFO - rmtree: /builds/slave/test-pgo/build 09:11:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:11:50 INFO - Running post-action listener: _resource_record_post_action 09:11:50 INFO - ##### 09:11:50 INFO - ##### Running read-buildbot-config step. 09:11:50 INFO - ##### 09:11:50 INFO - Running pre-action listener: _resource_record_pre_action 09:11:50 INFO - Running main action method: read_buildbot_config 09:11:50 INFO - Using buildbot properties: 09:11:50 INFO - { 09:11:50 INFO - "project": "", 09:11:50 INFO - "product": "firefox", 09:11:50 INFO - "script_repo_revision": "production", 09:11:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:11:50 INFO - "repository": "", 09:11:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:11:50 INFO - "buildid": "20160324062348", 09:11:50 INFO - "pgo_build": "True", 09:11:50 INFO - "basedir": "/builds/slave/test-pgo", 09:11:50 INFO - "buildnumber": 212, 09:11:50 INFO - "slavename": "talos-linux64-ix-059", 09:11:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:11:50 INFO - "platform": "ubuntu64_hw", 09:11:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:11:50 INFO - "branch": "mozilla-aurora", 09:11:50 INFO - "repo_path": "releases/mozilla-aurora", 09:11:50 INFO - "revision": "bf27bbf52e4be36dee46a9fd9fa94187a402f8bc", 09:11:50 INFO - "stage_platform": "linux64-pgo", 09:11:50 INFO - "builduid": "1df69062f8964cb7a794eedb42e1cf00", 09:11:50 INFO - "slavebuilddir": "test" 09:11:50 INFO - } 09:11:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:11:50 INFO - Running post-action listener: _resource_record_post_action 09:11:50 INFO - ##### 09:11:50 INFO - ##### Running download-and-extract step. 09:11:50 INFO - ##### 09:11:50 INFO - Running pre-action listener: _resource_record_pre_action 09:11:50 INFO - Running main action method: download_and_extract 09:11:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:50 INFO - https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:11:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:11:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:11:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:11:52 INFO - Downloaded 1448 bytes. 09:11:52 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:11:52 INFO - Using the following test package requirements: 09:11:52 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:11:52 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:11:52 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:11:52 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'jsshell-linux-x86_64.zip'], 09:11:52 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:11:52 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:11:52 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:11:52 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:11:52 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:11:52 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:11:52 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:11:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:11:52 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:11:52 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')]} 09:11:52 INFO - https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:12:02 INFO - Downloaded 23309971 bytes. 09:12:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:12:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:12:03 INFO - Return code: 0 09:12:03 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:12: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')]} 09:12:03 INFO - https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:12:48 INFO - Downloaded 23309971 bytes. 09:12:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:12:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:12:50 INFO - Return code: 0 09:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:12:50 INFO - https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:12:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:12:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:12:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:12:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:12:52 INFO - Downloaded 10845161 bytes. 09:12:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:12:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:12:52 INFO - Return code: 0 09:12:52 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')]} 09:12:52 INFO - https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:12:55 INFO - Downloaded 60449920 bytes. 09:12:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:12:55 INFO - mkdir: /builds/slave/test-pgo/properties 09:12:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:12:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:12:55 INFO - Contents: 09:12:55 INFO - build_url:https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:12:57 INFO - Running post-action listener: _resource_record_post_action 09:12:57 INFO - Running post-action listener: set_extra_try_arguments 09:12:57 INFO - ##### 09:12:57 INFO - ##### Running populate-webroot step. 09:12:57 INFO - ##### 09:12:57 INFO - Running pre-action listener: _resource_record_pre_action 09:12:57 INFO - Running main action method: populate_webroot 09:12:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:57 INFO - '--tppagecycles', 09:12:57 INFO - '7'], 09:12:57 INFO - 'tests': ['tsvgm']}}, 09:12:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:12:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:12:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'tests': ['damp', 'tps']}, 09:12:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['damp', 'tps']}, 09:12:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:12:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:57 INFO - 'other': {'tests': ['a11yr', 09:12:57 INFO - 'ts_paint', 09:12:57 INFO - 'tpaint', 09:12:57 INFO - 'sessionrestore', 09:12:57 INFO - 'sessionrestore_no_auto_restore', 09:12:57 INFO - 'tabpaint']}, 09:12:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['a11yr', 09:12:57 INFO - 'ts_paint', 09:12:57 INFO - 'tpaint', 09:12:57 INFO - 'sessionrestore', 09:12:57 INFO - 'sessionrestore_no_auto_restore', 09:12:57 INFO - 'tabpaint']}, 09:12:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['a11yr', 09:12:57 INFO - 'ts_paint', 09:12:57 INFO - 'tpaint', 09:12:57 INFO - 'sessionrestore', 09:12:57 INFO - 'sessionrestore_no_auto_restore', 09:12:57 INFO - 'tabpaint']}, 09:12:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['a11yr', 09:12:57 INFO - 'ts_paint', 09:12:57 INFO - 'tpaint', 09:12:57 INFO - 'sessionrestore', 09:12:57 INFO - 'sessionrestore_no_auto_restore', 09:12:57 INFO - 'tabpaint']}, 09:12:57 INFO - 'other_l64': {'tests': ['a11yr', 09:12:57 INFO - 'ts_paint', 09:12:57 INFO - 'tpaint', 09:12:57 INFO - 'sessionrestore', 09:12:57 INFO - 'sessionrestore_no_auto_restore', 09:12:57 INFO - 'tabpaint']}, 09:12:57 INFO - 'other_nol64': {'tests': ['a11yr', 09:12:57 INFO - 'ts_paint', 09:12:57 INFO - 'tpaint', 09:12:57 INFO - 'sessionrestore', 09:12:57 INFO - 'sessionrestore_no_auto_restore', 09:12:57 INFO - 'tabpaint']}, 09:12:57 INFO - 'svgr': {'tests': ['tsvgx', 09:12:57 INFO - 'tsvgr_opacity', 09:12:57 INFO - 'tart', 09:12:57 INFO - 'tscrollx', 09:12:57 INFO - 'cart']}, 09:12:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['tsvgx', 09:12:57 INFO - 'tsvgr_opacity', 09:12:57 INFO - 'tart', 09:12:57 INFO - 'tscrollx', 09:12:57 INFO - 'cart']}, 09:12:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'tests': ['tp5o']}, 09:12:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'talos_options': ['--e10s'], 09:12:57 INFO - 'tests': ['tp5o']}, 09:12:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'talos_options': ['--xperf_path', 09:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:57 INFO - 'tests': ['tp5n']}, 09:12:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:57 INFO - 'talos_options': ['--e10s', 09:12:57 INFO - '--xperf_path', 09:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:57 INFO - 'tests': ['tp5n']}}, 09:12:57 INFO - 'talos.zip': {'path': '', 09:12:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:57 INFO - Running post-action listener: _resource_record_post_action 09:12:57 INFO - ##### 09:12:57 INFO - ##### Running create-virtualenv step. 09:12:57 INFO - ##### 09:12:57 INFO - Running pre-action listener: _resource_record_pre_action 09:12:57 INFO - Running main action method: create_virtualenv 09:12:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:12:57 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 09:12:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:12:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:57 INFO - Using real prefix '/usr' 09:12:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:12:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:00 INFO - Installing pip.................done. 09:13:00 INFO - Return code: 0 09:13:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:00 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:00 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 09:13:00 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 09:13:00 INFO - Using env: {'DISPLAY': ':0', 09:13:00 INFO - 'HOME': '/home/cltbld', 09:13:00 INFO - 'LANG': 'en_US.UTF-8', 09:13:00 INFO - 'LANGUAGE': 'en_US:en', 09:13:00 INFO - 'LOGNAME': 'cltbld', 09:13:00 INFO - 'MAIL': '/var/mail/cltbld', 09:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:00 INFO - 'MOZ_NO_REMOTE': '1', 09:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:00 INFO - 'NO_EM_RESTART': '1', 09:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:00 INFO - 'SHELL': '/bin/bash', 09:13:00 INFO - 'SHLVL': '1', 09:13:00 INFO - 'TERM': 'linux', 09:13:00 INFO - 'TMOUT': '86400', 09:13:00 INFO - 'USER': 'cltbld', 09:13:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:00 INFO - '_': '/tools/buildbot/bin/python'} 09:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:00 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 09:13:00 INFO - Cleaning up... 09:13:00 INFO - Return code: 0 09:13:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:00 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:00 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 09:13:00 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 09:13:00 INFO - Using env: {'DISPLAY': ':0', 09:13:00 INFO - 'HOME': '/home/cltbld', 09:13:00 INFO - 'LANG': 'en_US.UTF-8', 09:13:00 INFO - 'LANGUAGE': 'en_US:en', 09:13:00 INFO - 'LOGNAME': 'cltbld', 09:13:00 INFO - 'MAIL': '/var/mail/cltbld', 09:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:00 INFO - 'MOZ_NO_REMOTE': '1', 09:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:00 INFO - 'NO_EM_RESTART': '1', 09:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:00 INFO - 'SHELL': '/bin/bash', 09:13:00 INFO - 'SHLVL': '1', 09:13:00 INFO - 'TERM': 'linux', 09:13:00 INFO - 'TMOUT': '86400', 09:13:00 INFO - 'USER': 'cltbld', 09:13:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:00 INFO - '_': '/tools/buildbot/bin/python'} 09:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:00 INFO - Downloading/unpacking psutil>=0.7.1 09:13:00 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 09:13:00 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 09:13:00 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 09:13:00 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 09:13:00 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 09:13:00 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 09:13:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:06 INFO - Installing collected packages: psutil 09:13:06 INFO - Running setup.py install for psutil 09:13:06 INFO - building 'psutil._psutil_linux' extension 09:13:06 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 09:13:06 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 09:13:06 INFO - building 'psutil._psutil_posix' extension 09:13:06 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 09:13:06 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 09:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:06 INFO - Successfully installed psutil 09:13:06 INFO - Cleaning up... 09:13:06 INFO - Return code: 0 09:13:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:06 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:06 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 09:13:06 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 09:13:06 INFO - Using env: {'DISPLAY': ':0', 09:13:06 INFO - 'HOME': '/home/cltbld', 09:13:06 INFO - 'LANG': 'en_US.UTF-8', 09:13:06 INFO - 'LANGUAGE': 'en_US:en', 09:13:06 INFO - 'LOGNAME': 'cltbld', 09:13:06 INFO - 'MAIL': '/var/mail/cltbld', 09:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:06 INFO - 'MOZ_NO_REMOTE': '1', 09:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:06 INFO - 'NO_EM_RESTART': '1', 09:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:06 INFO - 'SHELL': '/bin/bash', 09:13:06 INFO - 'SHLVL': '1', 09:13:06 INFO - 'TERM': 'linux', 09:13:06 INFO - 'TMOUT': '86400', 09:13:06 INFO - 'USER': 'cltbld', 09:13:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:06 INFO - '_': '/tools/buildbot/bin/python'} 09:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:13:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:13:12 INFO - Installing collected packages: mozsystemmonitor 09:13:12 INFO - Running setup.py install for mozsystemmonitor 09:13:12 INFO - Successfully installed mozsystemmonitor 09:13:12 INFO - Cleaning up... 09:13:12 INFO - Return code: 0 09:13:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:13: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')]} 09:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:12 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:12 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 09:13:12 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 09:13:12 INFO - Using env: {'DISPLAY': ':0', 09:13:12 INFO - 'HOME': '/home/cltbld', 09:13:12 INFO - 'LANG': 'en_US.UTF-8', 09:13:12 INFO - 'LANGUAGE': 'en_US:en', 09:13:12 INFO - 'LOGNAME': 'cltbld', 09:13:12 INFO - 'MAIL': '/var/mail/cltbld', 09:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:12 INFO - 'MOZ_NO_REMOTE': '1', 09:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:12 INFO - 'NO_EM_RESTART': '1', 09:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:12 INFO - 'SHELL': '/bin/bash', 09:13:12 INFO - 'SHLVL': '1', 09:13:12 INFO - 'TERM': 'linux', 09:13:12 INFO - 'TMOUT': '86400', 09:13:12 INFO - 'USER': 'cltbld', 09:13:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:12 INFO - '_': '/tools/buildbot/bin/python'} 09:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:13 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 09:13:13 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 09:13:13 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 09:13:13 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 09:13:13 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 09:13:13 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 09:13:21 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 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 09:13:21 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 09:13:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:13:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:23 INFO - Downloading docopt-0.6.1.tar.gz 09:13:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:23 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:23 INFO - Running setup.py install for blobuploader 09:13:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:13:24 INFO - Running setup.py install for requests 09:13:24 INFO - Running setup.py install for docopt 09:13:24 INFO - Successfully installed blobuploader requests docopt 09:13:24 INFO - Cleaning up... 09:13:24 INFO - Return code: 0 09:13:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:13:24 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')]} 09:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:24 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')]} 09:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:24 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:24 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 09:13:24 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 09:13:24 INFO - Using env: {'DISPLAY': ':0', 09:13:24 INFO - 'HOME': '/home/cltbld', 09:13:24 INFO - 'LANG': 'en_US.UTF-8', 09:13:24 INFO - 'LANGUAGE': 'en_US:en', 09:13:24 INFO - 'LOGNAME': 'cltbld', 09:13:24 INFO - 'MAIL': '/var/mail/cltbld', 09:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:24 INFO - 'MOZ_NO_REMOTE': '1', 09:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:24 INFO - 'NO_EM_RESTART': '1', 09:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:24 INFO - 'SHELL': '/bin/bash', 09:13:24 INFO - 'SHLVL': '1', 09:13:24 INFO - 'TERM': 'linux', 09:13:24 INFO - 'TMOUT': '86400', 09:13:24 INFO - 'USER': 'cltbld', 09:13:24 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:24 INFO - '_': '/tools/buildbot/bin/python'} 09:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:13:24 INFO - Running setup.py (path:/tmp/pip-9tXGfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:13:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:13:24 INFO - Running setup.py (path:/tmp/pip-SeCy4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:13:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:13:24 INFO - Running setup.py (path:/tmp/pip-dimvb2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:13:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:13:24 INFO - Running setup.py (path:/tmp/pip-7EV6f8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:13:25 INFO - Running setup.py (path:/tmp/pip-ixOHAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:13:25 INFO - Running setup.py (path:/tmp/pip-66G7uM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:13:25 INFO - Running setup.py (path:/tmp/pip-4Pe3nQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:13:25 INFO - Running setup.py (path:/tmp/pip-PdpQn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:13:25 INFO - Running setup.py (path:/tmp/pip-D6SkW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:13:25 INFO - Running setup.py (path:/tmp/pip-lf02ez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:13:25 INFO - Running setup.py (path:/tmp/pip-3aOcq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:13:25 INFO - Running setup.py (path:/tmp/pip-ySMKo6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:13:25 INFO - Running setup.py (path:/tmp/pip-YF7ULj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:13:25 INFO - Running setup.py (path:/tmp/pip-i94fB0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:13:25 INFO - Running setup.py (path:/tmp/pip-HfbqKP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:13:25 INFO - Running setup.py (path:/tmp/pip-skWoh_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:13:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:13:25 INFO - Running setup.py (path:/tmp/pip-O3PxRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:13:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:13:25 INFO - Running setup.py install for manifestparser 09:13:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Running setup.py install for mozcrash 09:13:26 INFO - Running setup.py install for mozdebug 09:13:26 INFO - Running setup.py install for mozdevice 09:13:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Running setup.py install for mozfile 09:13:26 INFO - Running setup.py install for mozhttpd 09:13:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Running setup.py install for mozinfo 09:13:26 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Running setup.py install for mozInstall 09:13:26 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:13:26 INFO - Running setup.py install for mozleak 09:13:26 INFO - Running setup.py install for mozlog 09:13:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Running setup.py install for moznetwork 09:13:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Running setup.py install for mozprocess 09:13:27 INFO - Running setup.py install for mozprofile 09:13:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Running setup.py install for mozrunner 09:13:27 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Running setup.py install for mozscreenshot 09:13:27 INFO - Running setup.py install for moztest 09:13:27 INFO - Running setup.py install for mozversion 09:13:27 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:13:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:13:27 INFO - Cleaning up... 09:13:27 INFO - Return code: 0 09:13:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:13:27 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')]} 09:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:27 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')]} 09:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:27 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:27 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 09:13:27 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 09:13:27 INFO - Using env: {'DISPLAY': ':0', 09:13:27 INFO - 'HOME': '/home/cltbld', 09:13:27 INFO - 'LANG': 'en_US.UTF-8', 09:13:27 INFO - 'LANGUAGE': 'en_US:en', 09:13:27 INFO - 'LOGNAME': 'cltbld', 09:13:27 INFO - 'MAIL': '/var/mail/cltbld', 09:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:27 INFO - 'MOZ_NO_REMOTE': '1', 09:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:27 INFO - 'NO_EM_RESTART': '1', 09:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:27 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:27 INFO - 'SHELL': '/bin/bash', 09:13:27 INFO - 'SHLVL': '1', 09:13:27 INFO - 'TERM': 'linux', 09:13:27 INFO - 'TMOUT': '86400', 09:13:27 INFO - 'USER': 'cltbld', 09:13:27 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:27 INFO - '_': '/tools/buildbot/bin/python'} 09:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:13:28 INFO - Running setup.py (path:/tmp/pip-p5MSRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:13:28 INFO - Running setup.py (path:/tmp/pip-pwo7hy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:13:28 INFO - Running setup.py (path:/tmp/pip-zgKt6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:13:28 INFO - Running setup.py (path:/tmp/pip-BZlsuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:13:28 INFO - Running setup.py (path:/tmp/pip-_jyDZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:13:28 INFO - Running setup.py (path:/tmp/pip-Nm4mZ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:13:28 INFO - Running setup.py (path:/tmp/pip-jXKx6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:13:28 INFO - Running setup.py (path:/tmp/pip-nIxDBc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:13:28 INFO - Running setup.py (path:/tmp/pip-KDzciU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:13:28 INFO - Running setup.py (path:/tmp/pip-QfRZil-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:13:28 INFO - Running setup.py (path:/tmp/pip-4TXxJS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:13:28 INFO - Running setup.py (path:/tmp/pip-6t7m0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:13:28 INFO - Running setup.py (path:/tmp/pip-o_XhB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:13:28 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)) 09:13:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:13:28 INFO - Running setup.py (path:/tmp/pip-HJFDTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:13:29 INFO - Running setup.py (path:/tmp/pip-Rh23jY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:13:29 INFO - Running setup.py (path:/tmp/pip-dyUMnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:13:29 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)) 09:13:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:13:29 INFO - Running setup.py (path:/tmp/pip-gorwwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:13:29 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)) 09:13:29 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)) 09:13:29 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)) 09:13:29 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)) 09:13:29 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)) 09:13:29 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)) 09:13:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:33 INFO - Downloading blessings-1.6.tar.gz 09:13:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:13:33 INFO - Installing collected packages: blessings 09:13:33 INFO - Running setup.py install for blessings 09:13:33 INFO - Successfully installed blessings 09:13:33 INFO - Cleaning up... 09:13:33 INFO - Return code: 0 09:13:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:13:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:13:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:13:33 INFO - Reading from file tmpfile_stdout 09:13:33 INFO - Current package versions: 09:13:33 INFO - argparse == 1.2.1 09:13:33 INFO - blessings == 1.6 09:13:33 INFO - blobuploader == 1.2.4 09:13:33 INFO - docopt == 0.6.1 09:13:33 INFO - manifestparser == 1.1 09:13:33 INFO - mozInstall == 1.12 09:13:33 INFO - mozcrash == 0.17 09:13:33 INFO - mozdebug == 0.1 09:13:33 INFO - mozdevice == 0.48 09:13:33 INFO - mozfile == 1.2 09:13:33 INFO - mozhttpd == 0.7 09:13:33 INFO - mozinfo == 0.9 09:13:33 INFO - mozleak == 0.1 09:13:33 INFO - mozlog == 3.1 09:13:33 INFO - moznetwork == 0.27 09:13:33 INFO - mozprocess == 0.22 09:13:33 INFO - mozprofile == 0.28 09:13:33 INFO - mozrunner == 6.11 09:13:33 INFO - mozscreenshot == 0.1 09:13:33 INFO - mozsystemmonitor == 0.0 09:13:33 INFO - moztest == 0.7 09:13:33 INFO - mozversion == 1.4 09:13:33 INFO - psutil == 3.1.1 09:13:33 INFO - requests == 1.2.3 09:13:33 INFO - wsgiref == 0.1.2 09:13:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:13:33 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')]} 09:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 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')]} 09:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:33 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 09:13:33 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 09:13:33 INFO - Using env: {'DISPLAY': ':0', 09:13:33 INFO - 'HOME': '/home/cltbld', 09:13:33 INFO - 'LANG': 'en_US.UTF-8', 09:13:33 INFO - 'LANGUAGE': 'en_US:en', 09:13:33 INFO - 'LOGNAME': 'cltbld', 09:13:33 INFO - 'MAIL': '/var/mail/cltbld', 09:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:33 INFO - 'MOZ_NO_REMOTE': '1', 09:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:33 INFO - 'NO_EM_RESTART': '1', 09:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:33 INFO - 'SHELL': '/bin/bash', 09:13:33 INFO - 'SHLVL': '1', 09:13:33 INFO - 'TERM': 'linux', 09:13:33 INFO - 'TMOUT': '86400', 09:13:33 INFO - 'USER': 'cltbld', 09:13:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:33 INFO - '_': '/tools/buildbot/bin/python'} 09:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 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)) 09:13:33 INFO - Cleaning up... 09:13:33 INFO - Return code: 0 09:13:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:13:33 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')]} 09:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 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')]} 09:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:33 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 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13:33 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 09:13:33 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 09:13:33 INFO - Using env: {'DISPLAY': ':0', 09:13:33 INFO - 'HOME': '/home/cltbld', 09:13:33 INFO - 'LANG': 'en_US.UTF-8', 09:13:33 INFO - 'LANGUAGE': 'en_US:en', 09:13:33 INFO - 'LOGNAME': 'cltbld', 09:13:33 INFO - 'MAIL': '/var/mail/cltbld', 09:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:33 INFO - 'MOZ_NO_REMOTE': '1', 09:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:33 INFO - 'NO_EM_RESTART': '1', 09:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:33 INFO - 'SHELL': '/bin/bash', 09:13:33 INFO - 'SHLVL': '1', 09:13:33 INFO - 'TERM': 'linux', 09:13:33 INFO - 'TMOUT': '86400', 09:13:33 INFO - 'USER': 'cltbld', 09:13:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:33 INFO - '_': '/tools/buildbot/bin/python'} 09:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:34 INFO - Downloading/unpacking jsonschema 09:13:34 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 09:13:34 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 09:13:34 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 09:13:34 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 09:13:34 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 09:13:34 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 09:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:13:38 INFO - Downloading/unpacking functools32 (from jsonschema) 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 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 09:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:13:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:13:38 INFO - warning: no files found matching '*.txt' 09:13:38 INFO - no previously-included directories found matching 'build' 09:13:38 INFO - no previously-included directories found matching 'dist' 09:13:38 INFO - no previously-included directories found matching '.git*' 09:13:38 INFO - Installing collected packages: jsonschema, functools32 09:13:39 INFO - Running setup.py install for functools32 09:13:39 INFO - warning: no files found matching '*.txt' 09:13:39 INFO - no previously-included directories found matching 'build' 09:13:39 INFO - no previously-included directories found matching 'dist' 09:13:39 INFO - no previously-included directories found matching '.git*' 09:13:39 INFO - Successfully installed jsonschema functools32 09:13:39 INFO - Cleaning up... 09:13:39 INFO - Return code: 0 09:13:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:13: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')]} 09:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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')]} 09:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7effe3295f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef06d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, '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': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', '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 09:13: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', 'flake8'] in /builds/slave/test-pgo/build 09:13: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 flake8 09:13:39 INFO - Using env: {'DISPLAY': ':0', 09:13:39 INFO - 'HOME': '/home/cltbld', 09:13:39 INFO - 'LANG': 'en_US.UTF-8', 09:13:39 INFO - 'LANGUAGE': 'en_US:en', 09:13:39 INFO - 'LOGNAME': 'cltbld', 09:13:39 INFO - 'MAIL': '/var/mail/cltbld', 09:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:39 INFO - 'MOZ_NO_REMOTE': '1', 09:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:39 INFO - 'NO_EM_RESTART': '1', 09:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:13:39 INFO - 'PWD': '/builds/slave/test-pgo', 09:13:39 INFO - 'SHELL': '/bin/bash', 09:13:39 INFO - 'SHLVL': '1', 09:13:39 INFO - 'TERM': 'linux', 09:13:39 INFO - 'TMOUT': '86400', 09:13:39 INFO - 'USER': 'cltbld', 09:13:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:39 INFO - '_': '/tools/buildbot/bin/python'} 09:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:39 INFO - Downloading/unpacking flake8 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:13:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:13:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:13:44 INFO - no previously-included directories found matching 'docs/_build' 09:13:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:13:44 INFO - Running setup.py install for pep8 09:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:13:44 INFO - no previously-included directories found matching 'docs/_build' 09:13:44 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:13:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:13:44 INFO - Cleaning up... 09:13:44 INFO - Return code: 0 09:13:44 INFO - Running post-action listener: _resource_record_post_action 09:13:44 INFO - Running post-action listener: _start_resource_monitoring 09:13:44 INFO - Starting resource monitoring. 09:13:44 INFO - ##### 09:13:44 INFO - ##### Running install step. 09:13:44 INFO - ##### 09:13:44 INFO - Running pre-action listener: _resource_record_pre_action 09:13:44 INFO - Running main action method: install 09:13:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:13:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:13:44 INFO - Reading from file tmpfile_stdout 09:13:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:13:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:13:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:13:45 INFO - Reading from file tmpfile_stdout 09:13:45 INFO - Output received: 09:13:45 INFO - Usage: mozinstall [options] installer 09:13:45 INFO - Options: 09:13:45 INFO - -h, --help show this help message and exit 09:13:45 INFO - -d DEST, --destination=DEST 09:13:45 INFO - Directory to install application into. [default: 09:13:45 INFO - "/builds/slave/test-pgo"] 09:13:45 INFO - --app=APP Application being installed. [default: firefox] 09:13:45 INFO - mkdir: /builds/slave/test-pgo/build/application 09:13:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:13:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:14:00 INFO - Reading from file tmpfile_stdout 09:14:00 INFO - Output received: 09:14:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:14:00 INFO - Running post-action listener: _resource_record_post_action 09:14:00 INFO - ##### 09:14:00 INFO - ##### Running run-tests step. 09:14:00 INFO - ##### 09:14:00 INFO - Running pre-action listener: _resource_record_pre_action 09:14:00 INFO - Running main action method: run_tests 09:14:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:14:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:14:00 INFO - Python 2.7.3 09:14:00 INFO - Return code: 0 09:14:00 INFO - grabbing minidump binary from tooltool 09:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:00 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 0xf7f920>, '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 0xf80820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:14:00 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 09:14:00 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 09:14:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:00 INFO - Return code: 0 09:14:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:14:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:14:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:14:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:14:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:14:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:14:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:14:01 INFO - Return code: 0 09:14:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:14:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:14:01 INFO - Using env: {'DISPLAY': ':0', 09:14:01 INFO - 'HOME': '/home/cltbld', 09:14:01 INFO - 'LANG': 'en_US.UTF-8', 09:14:01 INFO - 'LANGUAGE': 'en_US:en', 09:14:01 INFO - 'LOGNAME': 'cltbld', 09:14:01 INFO - 'MAIL': '/var/mail/cltbld', 09:14:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:14:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:01 INFO - 'MOZ_NO_REMOTE': '1', 09:14:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:01 INFO - 'NO_EM_RESTART': '1', 09:14:01 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:01 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:14:01 INFO - 'SHELL': '/bin/bash', 09:14:01 INFO - 'SHLVL': '1', 09:14:01 INFO - 'TERM': 'linux', 09:14:01 INFO - 'TMOUT': '86400', 09:14:01 INFO - 'USER': 'cltbld', 09:14:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917', 09:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:01 INFO - '_': '/tools/buildbot/bin/python'} 09:14:01 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:14:01 INFO - mozversion application_buildid: 20160324062348 09:14:01 INFO - mozversion application_changeset: bf27bbf52e4be36dee46a9fd9fa94187a402f8bc 09:14:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:14:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:01 INFO - mozversion application_name: Firefox 09:14:01 INFO - mozversion application_remotingname: firefox-dev 09:14:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:14:01 INFO - mozversion application_vendor: Mozilla 09:14:01 INFO - mozversion application_version: 47.0a2 09:14:01 INFO - mozversion platform_buildid: 20160324062348 09:14:01 INFO - mozversion platform_changeset: bf27bbf52e4be36dee46a9fd9fa94187a402f8bc 09:14:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:14:01 INFO - mozversion platform_version: 47.0a2 09:14:01 INFO - using testdate: 1458836041 09:14:01 INFO - actual date: 1458836041 09:14:01 INFO - starting webserver on 'localhost:39755' 09:14:01 INFO - SUITE-START | Running 2 tests 09:14:01 INFO - TEST-START | dromaeo_css 09:14:01 INFO - operating with platform_type : linux_ 09:14:01 INFO - Initialising browser for dromaeo_css test... 09:14:01 INFO - TEST-INFO | started process 3214 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRlpFkO/profile http://localhost:39755/getInfo.html) 09:14:04 INFO - PROCESS | 3214 | 09:14:04 INFO - PROCESS | 3214 | (process:3291): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:14:05 INFO - PROCESS | 3214 | __metrics Screen width/height:1600/1200 09:14:05 INFO - PROCESS | 3214 | colorDepth:24 09:14:05 INFO - PROCESS | 3214 | Browser inner width/height: 1024/697 09:14:05 INFO - PROCESS | 3214 | __metrics 09:14:06 ERROR - PROCESS | 3214 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:14:07 INFO - TEST-INFO | 3214: exit 0 09:14:07 INFO - Browser initialized. 09:14:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:07 INFO - TEST-INFO | started process 3342 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRlpFkO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:08 INFO - PROCESS | 3342 | 09:14:08 INFO - PROCESS | 3342 | (process:3411): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:14:18 INFO - PROCESS | 3342 | RSS: Main: 154554368 09:14:18 INFO - PROCESS | 3342 | 09:15:08 INFO - PROCESS | 3342 | 1458836108528 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] 09:17:16 INFO - PROCESS | 3342 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39755/tests/dromaeo/cssquery-ext.html) 09:17:17 INFO - PROCESS | 3342 | RSS: Main: 157659136 09:17:17 INFO - PROCESS | 3342 | 09:20:19 INFO - PROCESS | 3342 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-ext.html (next: http://localhost:39755/tests/dromaeo/cssquery-jquery.html) 09:20:19 INFO - PROCESS | 3342 | RSS: Main: 156868608 09:20:19 INFO - PROCESS | 3342 | 09:23:21 INFO - PROCESS | 3342 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39755/tests/dromaeo/cssquery-mootools.html) 09:23:22 INFO - PROCESS | 3342 | RSS: Main: 156078080 09:23:22 INFO - PROCESS | 3342 | 09:26:23 INFO - PROCESS | 3342 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39755/tests/dromaeo/cssquery-prototype.html) 09:26:24 INFO - PROCESS | 3342 | RSS: Main: 156102656 09:26:24 INFO - PROCESS | 3342 | 09:29:26 INFO - PROCESS | 3342 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39755/tests/dromaeo/cssquery-yui.html) 09:29:27 INFO - PROCESS | 3342 | RSS: Main: 155369472 09:29:27 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | Cycle 1(1): loaded http://localhost:39755/tests/dromaeo/cssquery-yui.html (next: http://localhost:39755/tests/dromaeo/cssquery-dojo.html) 09:32:29 INFO - PROCESS | 3342 | RSS: Main: 158433280 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | __start_tp_report 09:32:29 INFO - PROCESS | 3342 | _x_x_mozilla_page_load 09:32:29 INFO - PROCESS | 3342 | _x_x_mozilla_page_load_details 09:32:29 INFO - PROCESS | 3342 | |i|pagename|runs| 09:32:29 INFO - PROCESS | 3342 | |0;dojo.html;3286.293446908914;3315.4198015347306;3339.666033396662;3378.6283508814026;3379.72962163027;5319.361676598804;5392.595555333346;5426.131818908975;5426.972865135674;5463.125899856024;5374.8925021499645;5418.431064738195;5427.565794736422;5446.1558458439;5456.399796022434;4927.063857867011;4956.950430495703;4988.251762235657;5033.723145227011;5065.569426598743;4886.267059941019;4989.476105008976;4994.1260279451135;5047.823326183584;5056.418511871145;4968.3292755477905;4988.575971042465;5033.320501732274;5087.262346959688;5096.898062038757;5016.799328026875;5023.070731914608;5026.899462010758;5036.143855544529;5075.137226671474;4727.149113159629;4857.17428037231;4903.411590609114;4907.190313598252;5011.899762004776;5084.3644544431945;5152.124138896396;5153.458886816905;5161.071007218699;5200.635955483118;5625.718714064321;5627.212190293362;5658.321001479849;5660.037793575061;5664.150377443375;5735.741891614887;5798.043322851767;5871.618344807616;5909.143174239754;5923.940760592382;5464.535514481234;5468.316460442445;5471.316085489314;5478.342598888119;5485.149801780731;5857.941420585825;5910;5924.170616113747;5932.0508718604815;5940.46535811779;5671.007573674673;5725.799597014085;5732.885342293214;5734.254546908875;5756.769729210869;5779.190913272145;5789.681567513743;5789.884202316014;5790.913136302959;5800.651960882361;5677.602567820296;5728.1407788831175;5738.167965644958;5751.539876809845;5797.072468405035;5800.390958949334;5803;5811.825645230565;5818.883622327529;5843.707814609337;4394.8242070317465;4413.183561041217;4464.9107017860115;4473.686841921034;4498.100379924028;3941.8226179821977;3969.0871099647243;3988.561258261589;3996.2407142642805;4023.3562629979065;5424.294841670637;5556.222128901957;5562;5591.189277554732;5683.0338842396895;5872.471477566954;5890.793822216202;5919.733611987384;5944.256967879015;5983.252093488314;5536.501714845684;5542.584306177053;5552.555795536347;5554.166874968706;5555.50000499957;4948.480409557017;5019.096562618691;5031.371078615173;5041.369828771403;5110.207917772751;5956.076808094752;5966.105084237399;6001.609895356788;6007.549433792483;6009.759609615654;5807.593468457252;5816.505597024131;5817.243758311392;5817.563682723728;5819.970900145641;5950.553708471795;6052.182955301154;6093.421124993119;6120.538559592075;6130.141780150693;5746.224259724883;5774.971125144348;5778.104393818965;5786.392428794916;5794.884102318014;5702.230198923258;5844.327902291291;5878.088896221093;5885.293764748258;5890.116482527484;5730.799422020209;5774.335951365647;5794.043982742969;5799.536037116936;5833;5705.857353566194;5708.029634961983;5714.971425142848;5715.657060576379;5716.5426765859465;5459.890802184013;5570.972145139248;5579.525740311957;5636.267285252891;5670.546356291569;5751.827445176651;5787.305523337226;5792.9710351447975;5802.506786923159;5806.796762113306;5629.493345598916;5650.463205995424;5662.7734890603915;5668.0364338063455;5680.77276908919 09:32:29 INFO - PROCESS | 3342 | |1;ext.html;553.79786377972;578.1674388880012;625.3277726444072;638.2787450181296;651.4723074309812;30422.695773042262;38311;38826.22347553054;38920.221595568146;39052.41421378678;41961.79019104908;41983.58016419835;42035.57964420355;42259;42279.154416911646;8910.777230569256;9004.504752238625;9130.315226358016;9131.497767622777;9160.816783664322;8775.868361974575;8937.374383793138;8951.597178127;8952.641894324219;8970.955145224265;8863.822723545525;8903.421277616933;8914.108589141098;8974.192322690957;9017.864732029026;8814.294856411503;8909.68816091437;8942.552872356357;9092.181703646638;9110.726678199599;9083.273338133;9255.537223138816;9272.165505104573;9284;9297.395669281475;39873.20253594941;40234.79882600597;40251.59748402508;40277;40315.596844031475;3619.438986957026;3717.4052151655605;3717.9070523237137;3732.5147730794824;3771.2268984858038;32018.519722204186;32300.030999070066;32508.83745581257;32594.6740532594;32658;4038.717289789716;4102.979485102555;4142.2751018571935;4157.3140431828715;4203;283222;286352;286642;286672;287064.56467717735;46365.30452043222;46717.532824671995;46767.532324676315;62843.685781571716;63676.36323636704;43785.343219851726;43951.560484395384;44234.77882610566;44344.77827610906;44364.55635443604;15722.606934826721;15897.364105435885;16049.59876003086;16065.839341606668;16081.35674573004;12720.173188742701;12722.045846561545;12740.554080607135;12841.101122921305;12872.678183045311;15609.453669121527;15854.9207253963;15880.682386352208;15927.203639817963;15952.042877427391;6288.968555157195;6310.432061114522;6318.399752023551;6339.651319177489;6438.3883531064475;1044.1229367331478;1060.2313322840878;1103.9282446641103;1130.1749722702473;1134.3874307873655;28539.57190642142;29369.853150734536;29377.559336609967;29767;30351.241218969262;1146.6388087752332;1150.6835620204342;1200.0219820845982;1211.2913945342073;1245.420879291134;15298.847011529964;15386.230688465532;15597;15899.841001590068;16115.516534503984;359118;509810;520440;522700;525724;54591;55886.441135588124;56010;56071;56138.43861561332;1457.5335892514292;1483.9999999999784;1488.5459934719797;1490.87327577155;1500.8048953635957;28339.433211335247;28643.28391790222;28665.996690115746;28769.712302877542;28808.279793005342;50458.24312635387;50481.49518504768;50950;51128.23307650314;51165;327866;329955;331996;333642;333905;35259.47110793289;46756.29865551952;46812.29781553348;46829.53170468388;47756.28365574589;43381.78309108434;43554.78222608867;43627.781861090494;44037.559624403344;44363.55636443723;34462;34613;34926.65073349234;35314.47028294629;35606.109847254025;37707.62292377041;39496.696948800345;39939.80030099831;40093.398599021624;40527.1894562113;39500.80249598734;39530;39833.2033359337;40132.59867401289;40152.59847401606;34387.484187737704;34560.82719586386;34732.65267347294;35439.29121417609;35605.82197088998;27082.72917270802;27087.86456067707;27286;27294.317642059108;27361.31596710098 09:32:29 INFO - PROCESS | 3342 | |2;jquery.html;379.4251708661379;380.65360521925055;384.27755819060155;385.97105217108714;386.2834442109886;17878;18692.345767898125;19014.524636884085;19519.1216395262;19797;10598.894011059887;10779.08377787889;10781.8382724259;14108.506202282922;16127.113008784541;5000.899982000358;5211.687298762067;5235.816746413876;5243.842684719445;5271.789128434858;5217.399999000126;5412.702301373423;5416.160495123262;5420.4850539198715;5445.401005889349;5213.374395072597;5383.192521121824;5404.567634589223;5658.74535645897;5684.772609095652;5576.498115169654;5598.692071936042;5605.327360716719;5626.043572592628;5656.038473459522;5226.268322434862;5395.3525576931015;5423.023855705971;5635.09838425854;5650.152477128464;13001.869981300255;13059.542915997894;13117.737645247136;13211.669708257274;15485.845141548552;2312.6762253284555;2372.9762702372927;2373.335466069503;2380.8452450590657;2410.8794560271917;9293.535323233878;10263.384196948207;10636.627718029831;11263.042641375492;14055.718885622231;1911.9044047797554;1982.9900850495799;2015.0932080563805;2023.4435530229157;2027.888466134362;69874;71016;71369.28630713679;72254.27745722528;72501.63749181273;10266.58933642646;10382.480875956171;10502.527386267484;10527.21045921559;10559.577616895393;12034.699132521582;13543.66140846467;13556.11885227457;13581.592552223448;13617.727645447036;7811.765647030598;8070.1526339734655;8223.05434874997;8250.504969701837;8296.336293096538;8398.286145677686;8401.36989725773;8422.115677853859;8480.236778689947;8616.870746938801;4256.170046840898;4346.826126954949;4386.780660966939;4396.978015109904;4452.977735111303;1662.6508433228917;1671.6322409069985;1674.5227610131053;1695.2286709547127;1697.3012909473748;1000.3947611694965;1011.3022014809758;1076.2143635146388;1089.5206109311878;1118.854548908653;16105.838941610435;17626.383076592516;17699.292028318723;18371.265149393876;18376.356827510972;989.2877128467492;993.5380048277585;1006.5319626373771;1013.1185868294631;1017.0897047142765;10284.28010039305;10351.534180961875;10390.688279351632;10426.635067772591;10497.842532362021;406209;409146;421114;441156;446279;73417.26582734211;77765;78395.60802195953;79497;80105.19894800977;1046.4610725476387;1052.736815796051;1068.0547715271884;1068.2201992545486;1075.306427354352;15916.840831591537;16110.677786443972;16174.67650647004;16317.510474685778;16525.504234872973;27536.586951195346;33933.3213335727;36117.63882361143;36173.638263617024;36207.275854482235;46359.91380387823;47321.29018064801;47982.76008619935;49084.75457622689;50082;11010.669679909615;11426.600068997544;11519.366434846164;11609.709757256136;11718.941405292919;13077.346132693137;13167.144135631153;13251.536196233472;13300.534481293109;13490.392932317873;11267.760546339732;11452.828207576726;11565.248258863146;11683.415829208336;11770.58802941893;11371.829422558503;11466.426678666201;11497.482613282255;11648.941755291507;11718.648440546796;11419.371934543347;11693.12301577368;11989.34058626784;12086.637400877988;12197.512099516274;11457.541698331974;11474.541018359172;11589.188756787282;11685.123615728684;11726.296422214695;11874.940625296818;12014.159008869296;12022.75954480923;12033;12088.879111209128 09:32:29 INFO - PROCESS | 3342 | |3;mootools.html;1600.3438590178027;1624.2284914665536;1886.6792645250307;1932.3912967415254;1966.2036875065594;7555.584442855641;8383;8428.620712067956;8588.484690918549;8601.612927418266;8418.368622353333;8461.53461559614;8515.74452766418;8529.701460448885;8533.701320453785;2422.9878850605764;2436.3300092474533;2437.171361737009;2441.218809980807;2464.568700477418;2365.9171928982487;2385.821063420242;2390.629452434867;2391.8445301055376;2402.411409204747;2406.2660888429023;2434.4035711250767;2441.8412803167826;2485.092941076503;2498.525280196766;2456.459578892641;2468.7778099971088;2471.7404672509397;2478.950420991579;2488.4774197418565;2425.1148330859287;2438.1344622659053;2440.1947357372023;2444.669969554105;2454.0797201049604;8596.366690328818;8659.220670139717;8693.434926729742;8700.782480437976;8720.30237580992;5166.586673066184;5236.031334203147;5236.554892834114;5274.367075950872;5277.815276465343;3414.6926776590226;3417.40195465795;3455.0153206336327;3551.485034669958;3586.1572530455323;1061.7027232374946;1069.075249908831;1070.7804899995483;1074.6185104287943;1081.1674212210228;12017.218880772809;12050.939745301304;12065.33640649764;12116.15186936906;12160.331181784999;4635.281531362644;4639.744814035261;4728.668993170445;4739.66822322441;4749.501302363271;10044.397336159855;10093.798124037477;10122.240831937486;10122.949385253027;10127.898721012696;5232.843014709489;5243.134882744304;5268.894622107613;5279.498447647467;5308.761105750251;4231.767252801125;4669;4744.454387745384;4761;4798.856034318976;3921.9803900980883;4036.192761447722;4067.654249388776;4077.3068578341754;4111.5477297497255;1242.316725800806;1304.3347892574855;1314.3231235913513;1319.4326439630859;1330.1885849631717;1467.6330917270682;1484.1985327923016;1491.843356447579;1493.9701205975819;1504.1877386211543;8159.67361305553;8164.061132969666;8194.426390152632;8200;8222.38332125093;485.3956823754378;492.990140197194;495.23486213799765;495.6431369414016;498.2451585847444;6247.406496382836;6277.654728989949;6284.842878927972;6286.811395658137;6299.1811064562235;9977.650782222587;10162.745931351776;10179.898201018043;10211;10321.690349289533;10037.146842518321;10051.24615653829;10084.798304033879;10112.544935477921;10160.695179144637;7879.763607091796;8116;8117.8376432472205;8142.837143257102;8191.7712343149005;7604.733834315773;7762.689492420466;7842.686292548234;7856.25365590268;7860.449768516149;9141.817163656557;9233.769155771159;9244.768880778034;9376.765580860532;9584.712458626253;8970.506622135845;9234.261259099121;9587.280953928623;9595.184409325286;9658.517074146124;7894.21057894206;8039.437239393186;8064.758057258292;8085.353171746364;8265.380096492667;8189.79525511867;8222.506649601042;8291.751247462586;8318.750437486886;8333.374996875138;7413.518121322097;7496.7750967471065;7501.362384197404;7570.091589009354;7682.154962954182;7317.634118294171;7445.181030086795;7516;7582.734604288823;7716.074071111502;7845.0585929688805;7889.368850492062;7941.285284324438;7947.682092716226;7962.681492740226;7023.789286321418;7081.291870812877;7331;7346.412287017132;7349;7241.5293005954445;7300.817479563053;7302.817429564303;7312.597807120659;7337.26627337262 09:32:29 INFO - PROCESS | 3342 | |4;prototype.html;332.68893584498494;334.58678532012976;336.5339005477414;337.886807919347;344.2821716720637;6310.305866354703;6336.334684858092;6341.270753863307;6374.904376434351;6385.138006369139;6277.1839660844025;6349.238091429023;6349.238091429035;6360.204974378203;6378.808635740936;4635.490096089427;4705.882352941169;4743.857684269477;4754.595859351959;4823.517648235174;4720.268358404435;4748.406449193851;4751.21604935187;4764.97617511912;4786.042791441708;4679.953200468003;4754.120487709767;4758.571728544431;4762.1428142934255;4770.833020844271;4721.362616046824;4755.072760811643;4756.9286460703115;4775.689580177277;4778.331033655291;4103.076807718269;4107.527634322061;4108.4453598764085;4139.648129908961;4142.130152667944;6016.127661489059;6067.150598916155;6069.484093852028;6075.119107729354;6081.422264884829;5355.7857685692525;5515.145152501369;5516.586256030814;5531.612787104904;5535.39110697827;6515.70679319427;6629.767958121491;6629.93370066298;6654.567453115532;6670.3329667033395;4520.254158063915;4520.254158063948;4528.660350473728;4532.818687252506;4537.9773101134615;6960.617166055865;7000.544964577337;7028.75399361025;7044.154701435809;7055.964720176417;4494.977525112419;4551.52209018055;4601.28680054592;4625.838095666702;4642.582167604932;4710.788014539354;4714.339992401066;4716.575508204278;4717.95282047182;4725.125851717443;5520.889582208413;5521.1442226454965;5531.197976293495;5534.280543529316;5549.417311182348;6737;6763.458923286125;6764.864702705919;6770.119884415093;6775.966120169368;1616.4908053962963;1646.6212771062724;1663.6173680053655;1664.184549570726;1668.6495835874603;1079.3038490173794;1080.4381721504774;1083.344576531203;1086.5545126498098;1097.0839349143396;6451.483881289486;6468.579542329733;6493.902591461132;6500.804975850732;6516.641584712792;6891.689873955684;6909.7581584644295;6911.343422374866;6918;6929.896051559231;6448.355164483608;6463.741450341934;6466.612003279818;6486.286508484063;6501.284858665543;3722.925541489209;3725.385311423639;3729.8135093245774;3756.69946404287;3762.9623703762613;7141.250168732312;7342.229065947999;7364.594947277951;7379.963100184572;7386.4829461938225;7266.273372662798;7268.345848873627;7275.745348912763;7290.052293201956;7310.52481588695;7219.241979592172;7266.854662906818;7276.1996180419055;7306.525075870051;7312.268773122752;6969.756058537927;7101.786946391617;7102.964485177541;7107.715691372287;7109.3601575856355;6918.757843475454;6929.099217101744;6934.133233345832;6950.4787140965645;7006.2643422439905;7287.12554493443;7331.963340183265;7341.6329183541675;7349.448791340564;7352.301531354513;4595.977020114878;4620.0528891577815;4624.514425985223;4633.397658304399;4644.674872759009;6910.792676219721;7022.578645281299;7033.226345101933;7067.116610423697;7081.398081163159;6829.112215412163;6876.96845473183;6892.965535172292;6894.586324820527;6897.448204143757;6856.588604683735;6870.45036397097;6876.69054892541;6885.242623311332;6885.965570172117;6741.2921643226755;6752.257251702211;6763.357481039294;6768.526203165928;6777.966110169417;6727.596344219362;6881.827954301182;6896.655167241517;6914.4468442525485;6922.7923162305215;6696.263411024881;6734.528582999143;6738.090357801634;6742.932570674427;6751.156105486814 09:32:29 INFO - PROCESS | 3342 | |5;yui.html;718.5904034700217;728.4463807506294;784.5488843914749;870.4298684361742;891.9286457083434;17117.40089096882;17315.134243287815;17438.73841892371;17515.474535763915;17522.29910803568;16040.518784436457;16091.758623620655;16143.515694529153;16188.514344569652;16257.674846503063;896.4307664632972;918.191991047877;919.6275508419068;934.3319526538523;955.6225291010081;934.7990182110844;944.1549812917435;944.2776276148752;951.0632027452954;951.8143961927427;969.1084202533651;979.745266230778;979.9951000244989;980.5195454227448;983.9754006149832;961.6874515782399;966.0001898035534;966.4732720667254;969.767255858596;970.034815358719;712.2592503796046;715.4848509073511;718.4073139659802;719.2950908110029;719.6114098386864;15665.530034098882;15690.450834220748;15747.055176689435;15876.761848572281;15888.443904463289;13784.655383615389;14080.436782528686;14204.573862784133;14306.141631502143;14346.282685865664;11873.881261187364;11901.047916166686;11904.761904761943;12044;12228;3917.4319723639915;3955.1694144229746;4050.8379664813374;4052.1895620875944;4065.125997910434;49203.75398123022;49355.50644493581;49564;49756.50243497591;49767.502324976645;11486.253393529394;11525.76948461026;11646.24299420535;11762.059035277158;11901.464434100486;19681.803181967996;19926.800731992495;20090.296839610543;20102.296419625243;20121.899390503248;8355.7266141858;8416;8573.09982451846;8608.053114157437;8703.086175951561;4849.151398505247;4854.296127061627;4863.683860549053;4976.278439626234;5026.09530284545;3389.9152521187166;3408.4716868884866;3418.0258626291884;3424.760266781301;3436.3642726095754;663.6416335178949;666.2804171494774;669.0699927101333;672.3175976383974;673.7574473189648;694.0630149298406;714.589111261027;754.1930134755759;755.8374949385799;760.4942713095729;9014.909850901538;9151.67969121091;9181.311401644904;9192.95403522978;9303.58133883977;610.9327973922865;621.7730528357117;631.2961048431058;635.8481689652592;702.7786247332074;4197.265478541243;4235.4917409911;4284.67864910133;4298.075913678512;4434.933475997863;60449.39550604526;60502.69748651316;61312.693436533424;61948;62027.37972620216;54280.728596357556;55079;55792.442075579536;55795.44204557984;55906;50030.49969500331;50290.74854625703;51226.487735122915;51433.74283128561;52538;8526;8683.044865064965;8838.911610884066;8839.911600883908;8956.23029173202;36913;37426.8128659355;37542.624573755005;38534.42198367083;38712.80643596764;43584.34623480714;45567;46927.76536117298;48041.27938080861;48442.273365898836;10841.18691098155;11965.461554229907;12064.45709943037;12153;12206.633800985985;13483.05618606688;13535.86464135346;13692.589222323346;14018.439262429796;14413.711725765635;12237.082218833444;12662.303573303558;12676.366181690693;12680.23918564889;12838.229706217657;12341.814872777095;12759.298238596595;13233.86766132365;13286.402111904794;13299;12356.567520137112;12494.68763280889;12655.240685558896;12781.360931953552;12980.221186728826;10345.534450949875;10649.733756656145;10746.194035447217;11096.278741881752;11224.382658953837;10860.728481788019;10958.397288149228;10962.835557466486;11036.227464077438;11110.944445277722 09:32:29 INFO - PROCESS | 3342 | __end_tp_report 09:32:29 INFO - PROCESS | 3342 | __start_cc_report 09:32:29 INFO - PROCESS | 3342 | _x_x_mozilla_cycle_collect,328 09:32:29 INFO - PROCESS | 3342 | __end_cc_report 09:32:29 INFO - PROCESS | 3342 | __startTimestamp1458837149912__endTimestamp 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | ------- Summary: start ------- 09:32:29 INFO - PROCESS | 3342 | Number of tests: 6 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | [#0] dojo.html Cycles:165 Average:5415.93 Median:5658.32 stddev:591.29 (10.4%) stddev-sans-first:569.01 09:32:29 INFO - PROCESS | 3342 | Values: 3286.3 3315.4 3339.7 3378.6 3379.7 5319.4 5392.6 5426.1 5427.0 5463.1 5374.9 5418.4 5427.6 5446.2 5456.4 4927.1 4957.0 4988.3 5033.7 5065.6 4886.3 4989.5 4994.1 5047.8 5056.4 4968.3 4988.6 5033.3 5087.3 5096.9 5016.8 5023.1 5026.9 5036.1 5075.1 4727.1 4857.2 4903.4 4907.2 5011.9 5084.4 5152.1 5153.5 5161.1 5200.6 5625.7 5627.2 5658.3 5660.0 5664.2 5735.7 5798.0 5871.6 5909.1 5923.9 5464.5 5468.3 5471.3 5478.3 5485.1 5857.9 5910.0 5924.2 5932.1 5940.5 5671.0 5725.8 5732.9 5734.3 5756.8 5779.2 5789.7 5789.9 5790.9 5800.7 5677.6 5728.1 5738.2 5751.5 5797.1 5800.4 5803.0 5811.8 5818.9 5843.7 4394.8 4413.2 4464.9 4473.7 4498.1 3941.8 3969.1 3988.6 3996.2 4023.4 5424.3 5556.2 5562.0 5591.2 5683.0 5872.5 5890.8 5919.7 5944.3 5983.3 5536.5 5542.6 5552.6 5554.2 5555.5 4948.5 5019.1 5031.4 5041.4 5110.2 5956.1 5966.1 6001.6 6007.5 6009.8 5807.6 5816.5 5817.2 5817.6 5820.0 5950.6 6052.2 6093.4 6120.5 6130.1 5746.2 5775.0 5778.1 5786.4 5794.9 5702.2 5844.3 5878.1 5885.3 5890.1 5730.8 5774.3 5794.0 5799.5 5833.0 5705.9 5708.0 5715.0 5715.7 5716.5 5459.9 5571.0 5579.5 5636.3 5670.5 5751.8 5787.3 5793.0 5802.5 5806.8 5629.5 5650.5 5662.8 5668.0 5680.8 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | [#1] ext.html Cycles:180 Average:52997.22 Median:39681.60 stddev:100579.30 (253.5%) stddev-sans-first:100784.38 09:32:29 INFO - PROCESS | 3342 | Values: 553.8 578.2 625.3 638.3 651.5 30422.7 38311.0 38826.2 38920.2 39052.4 41961.8 41983.6 42035.6 42259.0 42279.2 8910.8 9004.5 9130.3 9131.5 9160.8 8775.9 8937.4 8951.6 8952.6 8971.0 8863.8 8903.4 8914.1 8974.2 9017.9 8814.3 8909.7 8942.6 9092.2 9110.7 9083.3 9255.5 9272.2 9284.0 9297.4 39873.2 40234.8 40251.6 40277.0 40315.6 3619.4 3717.4 3717.9 3732.5 3771.2 32018.5 32300.0 32508.8 32594.7 32658.0 4038.7 4103.0 4142.3 4157.3 4203.0 283222.0 286352.0 286642.0 286672.0 287064.6 46365.3 46717.5 46767.5 62843.7 63676.4 43785.3 43951.6 44234.8 44344.8 44364.6 15722.6 15897.4 16049.6 16065.8 16081.4 12720.2 12722.0 12740.6 12841.1 12872.7 15609.5 15854.9 15880.7 15927.2 15952.0 6289.0 6310.4 6318.4 6339.7 6438.4 1044.1 1060.2 1103.9 1130.2 1134.4 28539.6 29369.9 29377.6 29767.0 30351.2 1146.6 1150.7 1200.0 1211.3 1245.4 15298.8 15386.2 15597.0 15899.8 16115.5 359118.0 509810.0 520440.0 522700.0 525724.0 54591.0 55886.4 56010.0 56071.0 56138.4 1457.5 1484.0 1488.5 1490.9 1500.8 28339.4 28643.3 28666.0 28769.7 28808.3 50458.2 50481.5 50950.0 51128.2 51165.0 327866.0 329955.0 331996.0 333642.0 333905.0 35259.5 46756.3 46812.3 46829.5 47756.3 43381.8 43554.8 43627.8 44037.6 44363.6 34462.0 34613.0 34926.7 35314.5 35606.1 37707.6 39496.7 39939.8 40093.4 40527.2 39500.8 39530.0 39833.2 40132.6 40152.6 34387.5 34560.8 34732.7 35439.3 35605.8 27082.7 27087.9 27286.0 27294.3 27361.3 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | [#2] jquery.html Cycles:180 Average:25588.22 Median:18124.63 stddev:69896.09 (385.6%) stddev-sans-first:70066.54 09:32:29 INFO - PROCESS | 3342 | Values: 379.4 380.7 384.3 386.0 386.3 17878.0 18692.3 19014.5 19519.1 19797.0 10598.9 10779.1 10781.8 14108.5 16127.1 5000.9 5211.7 5235.8 5243.8 5271.8 5217.4 5412.7 5416.2 5420.5 5445.4 5213.4 5383.2 5404.6 5658.7 5684.8 5576.5 5598.7 5605.3 5626.0 5656.0 5226.3 5395.4 5423.0 5635.1 5650.2 13001.9 13059.5 13117.7 13211.7 15485.8 2312.7 2373.0 2373.3 2380.8 2410.9 9293.5 10263.4 10636.6 11263.0 14055.7 1911.9 1983.0 2015.1 2023.4 2027.9 69874.0 71016.0 71369.3 72254.3 72501.6 10266.6 10382.5 10502.5 10527.2 10559.6 12034.7 13543.7 13556.1 13581.6 13617.7 7811.8 8070.2 8223.1 8250.5 8296.3 8398.3 8401.4 8422.1 8480.2 8616.9 4256.2 4346.8 4386.8 4397.0 4453.0 1662.7 1671.6 1674.5 1695.2 1697.3 1000.4 1011.3 1076.2 1089.5 1118.9 16105.8 17626.4 17699.3 18371.3 18376.4 989.3 993.5 1006.5 1013.1 1017.1 10284.3 10351.5 10390.7 10426.6 10497.8 406209.0 409146.0 421114.0 441156.0 446279.0 73417.3 77765.0 78395.6 79497.0 80105.2 1046.5 1052.7 1068.1 1068.2 1075.3 15916.8 16110.7 16174.7 16317.5 16525.5 27536.6 33933.3 36117.6 36173.6 36207.3 46359.9 47321.3 47982.8 49084.8 50082.0 11010.7 11426.6 11519.4 11609.7 11718.9 13077.3 13167.1 13251.5 13300.5 13490.4 11267.8 11452.8 11565.2 11683.4 11770.6 11371.8 11466.4 11497.5 11648.9 11718.6 11419.4 11693.1 11989.3 12086.6 12197.5 11457.5 11474.5 11589.2 11685.1 11726.3 11874.9 12014.2 12022.8 12033.0 12088.9 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | [#3] mootools.html Cycles:180 Average:6015.15 Median:5234.44 stddev:3153.22 (60.2%) stddev-sans-first:3144.61 09:32:29 INFO - PROCESS | 3342 | Values: 1600.3 1624.2 1886.7 1932.4 1966.2 7555.6 8383.0 8428.6 8588.5 8601.6 8418.4 8461.5 8515.7 8529.7 8533.7 2423.0 2436.3 2437.2 2441.2 2464.6 2365.9 2385.8 2390.6 2391.8 2402.4 2406.3 2434.4 2441.8 2485.1 2498.5 2456.5 2468.8 2471.7 2479.0 2488.5 2425.1 2438.1 2440.2 2444.7 2454.1 8596.4 8659.2 8693.4 8700.8 8720.3 5166.6 5236.0 5236.6 5274.4 5277.8 3414.7 3417.4 3455.0 3551.5 3586.2 1061.7 1069.1 1070.8 1074.6 1081.2 12017.2 12050.9 12065.3 12116.2 12160.3 4635.3 4639.7 4728.7 4739.7 4749.5 10044.4 10093.8 10122.2 10122.9 10127.9 5232.8 5243.1 5268.9 5279.5 5308.8 4231.8 4669.0 4744.5 4761.0 4798.9 3922.0 4036.2 4067.7 4077.3 4111.5 1242.3 1304.3 1314.3 1319.4 1330.2 1467.6 1484.2 1491.8 1494.0 1504.2 8159.7 8164.1 8194.4 8200.0 8222.4 485.4 493.0 495.2 495.6 498.2 6247.4 6277.7 6284.8 6286.8 6299.2 9977.7 10162.7 10179.9 10211.0 10321.7 10037.1 10051.2 10084.8 10112.5 10160.7 7879.8 8116.0 8117.8 8142.8 8191.8 7604.7 7762.7 7842.7 7856.3 7860.4 9141.8 9233.8 9244.8 9376.8 9584.7 8970.5 9234.3 9587.3 9595.2 9658.5 7894.2 8039.4 8064.8 8085.4 8265.4 8189.8 8222.5 8291.8 8318.8 8333.4 7413.5 7496.8 7501.4 7570.1 7682.2 7317.6 7445.2 7516.0 7582.7 7716.1 7845.1 7889.4 7941.3 7947.7 7962.7 7023.8 7081.3 7331.0 7346.4 7349.0 7241.5 7300.8 7302.8 7312.6 7337.3 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | [#4] prototype.html Cycles:180 Average:5633.40 Median:6449.92 stddev:1755.28 (27.2%) stddev-sans-first:1714.52 09:32:29 INFO - PROCESS | 3342 | Values: 332.7 334.6 336.5 337.9 344.3 6310.3 6336.3 6341.3 6374.9 6385.1 6277.2 6349.2 6349.2 6360.2 6378.8 4635.5 4705.9 4743.9 4754.6 4823.5 4720.3 4748.4 4751.2 4765.0 4786.0 4680.0 4754.1 4758.6 4762.1 4770.8 4721.4 4755.1 4756.9 4775.7 4778.3 4103.1 4107.5 4108.4 4139.6 4142.1 6016.1 6067.2 6069.5 6075.1 6081.4 5355.8 5515.1 5516.6 5531.6 5535.4 6515.7 6629.8 6629.9 6654.6 6670.3 4520.3 4520.3 4528.7 4532.8 4538.0 6960.6 7000.5 7028.8 7044.2 7056.0 4495.0 4551.5 4601.3 4625.8 4642.6 4710.8 4714.3 4716.6 4718.0 4725.1 5520.9 5521.1 5531.2 5534.3 5549.4 6737.0 6763.5 6764.9 6770.1 6776.0 1616.5 1646.6 1663.6 1664.2 1668.6 1079.3 1080.4 1083.3 1086.6 1097.1 6451.5 6468.6 6493.9 6500.8 6516.6 6891.7 6909.8 6911.3 6918.0 6929.9 6448.4 6463.7 6466.6 6486.3 6501.3 3722.9 3725.4 3729.8 3756.7 3763.0 7141.3 7342.2 7364.6 7380.0 7386.5 7266.3 7268.3 7275.7 7290.1 7310.5 7219.2 7266.9 7276.2 7306.5 7312.3 6969.8 7101.8 7103.0 7107.7 7109.4 6918.8 6929.1 6934.1 6950.5 7006.3 7287.1 7332.0 7341.6 7349.4 7352.3 4596.0 4620.1 4624.5 4633.4 4644.7 6910.8 7022.6 7033.2 7067.1 7081.4 6829.1 6877.0 6893.0 6894.6 6897.4 6856.6 6870.5 6876.7 6885.2 6886.0 6741.3 6752.3 6763.4 6768.5 6778.0 6727.6 6881.8 6896.7 6914.4 6922.8 6696.3 6734.5 6738.1 6742.9 6751.2 09:32:29 INFO - PROCESS | 3342 | 09:32:29 INFO - PROCESS | 3342 | [#5] yui.html Cycles:180 Average:15135.47 Median:25000.97 stddev:16956.78 (67.8%) stddev-sans-first:16969.78 09:32:29 INFO - PROCESS | 3342 | Values: 718.6 728.4 784.5 870.4 891.9 17117.4 17315.1 17438.7 17515.5 17522.3 16040.5 16091.8 16143.5 16188.5 16257.7 896.4 918.2 919.6 934.3 955.6 934.8 944.2 944.3 951.1 951.8 969.1 979.7 980.0 980.5 984.0 961.7 966.0 966.5 969.8 970.0 712.3 715.5 718.4 719.3 719.6 15665.5 15690.5 15747.1 15876.8 15888.4 13784.7 14080.4 14204.6 14306.1 14346.3 11873.9 11901.0 11904.8 12044.0 12228.0 3917.4 3955.2 4050.8 4052.2 4065.1 49203.8 49355.5 49564.0 49756.5 49767.5 11486.3 11525.8 11646.2 11762.1 11901.5 19681.8 19926.8 20090.3 20102.3 20121.9 8355.7 8416.0 8573.1 8608.1 8703.1 4849.2 4854.3 4863.7 4976.3 5026.1 3389.9 3408.5 3418.0 3424.8 3436.4 663.6 666.3 669.1 672.3 673.8 694.1 714.6 754.2 755.8 760.5 9014.9 9151.7 9181.3 9193.0 9303.6 610.9 621.8 631.3 635.8 702.8 4197.3 4235.5 4284.7 4298.1 4434.9 60449.4 60502.7 61312.7 61948.0 62027.4 54280.7 55079.0 55792.4 55795.4 55906.0 50030.5 50290.7 51226.5 51433.7 52538.0 8526.0 8683.0 8838.9 8839.9 8956.2 36913.0 37426.8 37542.6 38534.4 38712.8 43584.3 45567.0 46927.8 48041.3 48442.3 10841.2 11965.5 12064.5 12153.0 12206.6 13483.1 13535.9 13692.6 14018.4 14413.7 12237.1 12662.3 12676.4 12680.2 12838.2 12341.8 12759.3 13233.9 13286.4 13299.0 12356.6 12494.7 12655.2 12781.4 12980.2 10345.5 10649.7 10746.2 11096.3 11224.4 10860.7 10958.4 10962.8 11036.2 11110.9 09:32:29 INFO - PROCESS | 3342 | -------- Summary: end -------- 09:32:29 INFO - PROCESS | 3342 | 09:32:30 INFO - TEST-INFO | 3342: exit 0 09:32:30 INFO - TEST-OK | dromaeo_css | took 1109100ms 09:32:30 INFO - TEST-START | kraken 09:32:30 INFO - operating with platform_type : linux_ 09:32:30 INFO - Initialising browser for kraken test... 09:32:30 INFO - TEST-INFO | started process 3587 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP2g0yu/profile http://localhost:39755/getInfo.html) 09:32:34 INFO - PROCESS | 3587 | 09:32:34 INFO - PROCESS | 3587 | (process:3665): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:32:34 INFO - PROCESS | 3587 | __metrics Screen width/height:1600/1200 09:32:34 INFO - PROCESS | 3587 | colorDepth:24 09:32:34 INFO - PROCESS | 3587 | Browser inner width/height: 1024/697 09:32:34 INFO - PROCESS | 3587 | __metrics 09:32:35 ERROR - PROCESS | 3587 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:32:36 INFO - TEST-INFO | 3587: exit 0 09:32:36 INFO - Browser initialized. 09:32:36 INFO - Running cycle 1/1 for kraken test... 09:32:36 INFO - TEST-INFO | started process 3716 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP2g0yu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:38 INFO - PROCESS | 3716 | 09:32:38 INFO - PROCESS | 3716 | (process:3781): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:32:48 INFO - PROCESS | 3716 | RSS: Main: 153997312 09:32:48 INFO - PROCESS | 3716 | 09:32:50 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:51 INFO - PROCESS | 3716 | RSS: Main: 159326208 09:32:51 INFO - PROCESS | 3716 | 09:32:53 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-dft) 09:32:54 INFO - PROCESS | 3716 | RSS: Main: 158765056 09:32:54 INFO - PROCESS | 3716 | 09:32:57 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-fft) 09:32:57 INFO - PROCESS | 3716 | RSS: Main: 158597120 09:32:57 INFO - PROCESS | 3716 | 09:32:59 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39755/tests/kraken/driver.html?testName=audio-oscillator) 09:33:00 INFO - PROCESS | 3716 | RSS: Main: 158310400 09:33:00 INFO - PROCESS | 3716 | 09:33:02 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:03 INFO - PROCESS | 3716 | RSS: Main: 158461952 09:33:03 INFO - PROCESS | 3716 | 09:33:06 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39755/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:06 INFO - PROCESS | 3716 | RSS: Main: 158097408 09:33:06 INFO - PROCESS | 3716 | 09:33:10 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39755/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:11 INFO - PROCESS | 3716 | RSS: Main: 159559680 09:33:11 INFO - PROCESS | 3716 | 09:33:13 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39755/tests/kraken/driver.html?testName=json-parse-financial) 09:33:14 INFO - PROCESS | 3716 | RSS: Main: 159584256 09:33:14 INFO - PROCESS | 3716 | 09:33:16 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:16 INFO - PROCESS | 3716 | RSS: Main: 158138368 09:33:16 INFO - PROCESS | 3716 | 09:33:18 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:19 INFO - PROCESS | 3716 | RSS: Main: 158351360 09:33:19 INFO - PROCESS | 3716 | 09:33:21 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:33:21 INFO - PROCESS | 3716 | RSS: Main: 158765056 09:33:21 INFO - PROCESS | 3716 | 09:33:24 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:33:24 INFO - PROCESS | 3716 | RSS: Main: 158248960 09:33:24 INFO - PROCESS | 3716 | 09:33:27 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:33:27 INFO - PROCESS | 3716 | RSS: Main: 158523392 09:33:27 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | Cycle 1(1): loaded http://localhost:39755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39755/tests/kraken/driver.html?testName=ai-astar) 09:33:29 INFO - PROCESS | 3716 | RSS: Main: 161112064 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | __start_tp_report 09:33:29 INFO - PROCESS | 3716 | _x_x_mozilla_page_load 09:33:29 INFO - PROCESS | 3716 | _x_x_mozilla_page_load_details 09:33:29 INFO - PROCESS | 3716 | |i|pagename|runs| 09:33:29 INFO - PROCESS | 3716 | |0;ai-astar;112;103;110;110;112;123;110;110;110;111 09:33:29 INFO - PROCESS | 3716 | |1;audio-beat-detection;155;122;153;163;129;162;147;129;163;127 09:33:29 INFO - PROCESS | 3716 | |2;audio-dft;163;164;161;160;160;161;162;163;163;167 09:33:29 INFO - PROCESS | 3716 | |3;audio-fft;76;74;75;163;74;76;76;73;156;78 09:33:29 INFO - PROCESS | 3716 | |4;audio-oscillator;93;92;142;92;93;92;145;93;93;142 09:33:29 INFO - PROCESS | 3716 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;117;117 09:33:29 INFO - PROCESS | 3716 | |6;imaging-darkroom;147;146;153;149;150;149;146;147;148;147 09:33:29 INFO - PROCESS | 3716 | |7;imaging-desaturate;96;96;96;96;97;97;96;97;96;96 09:33:29 INFO - PROCESS | 3716 | |8;json-parse-financial;59;57;59;56;57;70;60;64;58;56 09:33:29 INFO - PROCESS | 3716 | |9;json-stringify-tinderbox;71;72;71;72;71;72;72;72;73;72 09:33:29 INFO - PROCESS | 3716 | |10;stanford-crypto-aes;78;79;81;82;80;82;90;79;80;79 09:33:29 INFO - PROCESS | 3716 | |11;stanford-crypto-ccm;115;123;111;123;114;111;118;116;116;124 09:33:29 INFO - PROCESS | 3716 | |12;stanford-crypto-pbkdf2;141;148;153;146;147;149;149;151;148;139 09:33:29 INFO - PROCESS | 3716 | |13;stanford-crypto-sha256-iterative;68;68;69;68;71;65;72;66;66;67 09:33:29 INFO - PROCESS | 3716 | __end_tp_report 09:33:29 INFO - PROCESS | 3716 | __start_cc_report 09:33:29 INFO - PROCESS | 3716 | _x_x_mozilla_cycle_collect,831 09:33:29 INFO - PROCESS | 3716 | __end_cc_report 09:33:29 INFO - PROCESS | 3716 | __startTimestamp1458837209785__endTimestamp 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | ------- Summary: start ------- 09:33:29 INFO - PROCESS | 3716 | Number of tests: 14 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:4.89 (4.4%) stddev-sans-first:5.17 09:33:29 INFO - PROCESS | 3716 | Values: 112.0 103.0 110.0 110.0 112.0 123.0 110.0 110.0 110.0 111.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:154.00 stddev:16.57 (10.8%) stddev-sans-first:17.17 09:33:29 INFO - PROCESS | 3716 | Values: 155.0 122.0 153.0 163.0 129.0 162.0 147.0 129.0 163.0 127.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 09:33:29 INFO - PROCESS | 3716 | Values: 163.0 164.0 161.0 160.0 160.0 161.0 162.0 163.0 163.0 167.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.50 stddev:35.59 (47.1%) stddev-sans-first:37.27 09:33:29 INFO - PROCESS | 3716 | Values: 76.0 74.0 75.0 163.0 74.0 76.0 76.0 73.0 156.0 78.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:92.50 stddev:24.38 (26.4%) stddev-sans-first:25.27 09:33:29 INFO - PROCESS | 3716 | Values: 93.0 92.0 142.0 92.0 93.0 92.0 145.0 93.0 93.0 142.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:33:29 INFO - PROCESS | 3716 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:2.15 (1.4%) stddev-sans-first:2.24 09:33:29 INFO - PROCESS | 3716 | Values: 147.0 146.0 153.0 149.0 150.0 149.0 146.0 147.0 148.0 147.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:33:29 INFO - PROCESS | 3716 | Values: 96.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:4.35 (7.4%) stddev-sans-first:4.61 09:33:29 INFO - PROCESS | 3716 | Values: 59.0 57.0 59.0 56.0 57.0 70.0 60.0 64.0 58.0 56.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 09:33:29 INFO - PROCESS | 3716 | Values: 71.0 72.0 71.0 72.0 71.0 72.0 72.0 72.0 73.0 72.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:3.43 (4.3%) stddev-sans-first:3.46 09:33:29 INFO - PROCESS | 3716 | Values: 78.0 79.0 81.0 82.0 80.0 82.0 90.0 79.0 80.0 79.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:117.00 stddev:4.82 (4.1%) stddev-sans-first:5.05 09:33:29 INFO - PROCESS | 3716 | Values: 115.0 123.0 111.0 123.0 114.0 111.0 118.0 116.0 116.0 124.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:148.50 stddev:4.25 (2.9%) stddev-sans-first:3.90 09:33:29 INFO - PROCESS | 3716 | Values: 141.0 148.0 153.0 146.0 147.0 149.0 149.0 151.0 148.0 139.0 09:33:29 INFO - PROCESS | 3716 | 09:33:29 INFO - PROCESS | 3716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.21 (3.3%) stddev-sans-first:2.35 09:33:29 INFO - PROCESS | 3716 | Values: 68.0 68.0 69.0 68.0 71.0 65.0 72.0 66.0 66.0 67.0 09:33:29 INFO - PROCESS | 3716 | -------- Summary: end -------- 09:33:29 INFO - PROCESS | 3716 | 09:33:30 INFO - TEST-INFO | 3716: exit 0 09:33:30 INFO - TEST-OK | kraken | took 60127ms 09:33:30 INFO - SUITE-END | took 1169s 09:33:30 INFO - Completed test suite (00:19:29) 09:33:30 INFO - javascript benchmark 09:33:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3286.293446908914, 3315.4198015347306, 3339.666033396662, 3378.6283508814026, 3379.72962163027, 5319.361676598804, 5392.595555333346, 5426.131818908975, 5426.972865135674, 5463.125899856024, 5374.8925021499645, 5418.431064738195, 5427.565794736422, 5446.1558458439, 5456.399796022434, 4927.063857867011, 4956.950430495703, 4988.251762235657, 5033.723145227011, 5065.569426598743, 4886.267059941019, 4989.476105008976, 4994.1260279451135, 5047.823326183584, 5056.418511871145, 4968.3292755477905, 4988.575971042465, 5033.320501732274, 5087.262346959688, 5096.898062038757, 5016.799328026875, 5023.070731914608, 5026.899462010758, 5036.143855544529, 5075.137226671474, 4727.149113159629, 4857.17428037231, 4903.411590609114, 4907.190313598252, 5011.899762004776, 5084.3644544431945, 5152.124138896396, 5153.458886816905, 5161.071007218699, 5200.635955483118, 5625.718714064321, 5627.212190293362, 5658.321001479849, 5660.037793575061, 5664.150377443375, 5735.741891614887, 5798.043322851767, 5871.618344807616, 5909.143174239754, 5923.940760592382, 5464.535514481234, 5468.316460442445, 5471.316085489314, 5478.342598888119, 5485.149801780731, 5857.941420585825, 5910.0, 5924.170616113747, 5932.0508718604815, 5940.46535811779, 5671.007573674673, 5725.799597014085, 5732.885342293214, 5734.254546908875, 5756.769729210869, 5779.190913272145, 5789.681567513743, 5789.884202316014, 5790.913136302959, 5800.651960882361, 5677.602567820296, 5728.1407788831175, 5738.167965644958, 5751.539876809845, 5797.072468405035, 5800.390958949334, 5803.0, 5811.825645230565, 5818.883622327529, 5843.707814609337, 4394.8242070317465, 4413.183561041217, 4464.9107017860115, 4473.686841921034, 4498.100379924028, 3941.8226179821977, 3969.0871099647243, 3988.561258261589, 3996.2407142642805, 4023.3562629979065, 5424.294841670637, 5556.222128901957, 5562.0, 5591.189277554732, 5683.0338842396895, 5872.471477566954, 5890.793822216202, 5919.733611987384, 5944.256967879015, 5983.252093488314, 5536.501714845684, 5542.584306177053, 5552.555795536347, 5554.166874968706, 5555.50000499957, 4948.480409557017, 5019.096562618691, 5031.371078615173, 5041.369828771403, 5110.207917772751, 5956.076808094752, 5966.105084237399, 6001.609895356788, 6007.549433792483, 6009.759609615654, 5807.593468457252, 5816.505597024131, 5817.243758311392, 5817.563682723728, 5819.970900145641, 5950.553708471795, 6052.182955301154, 6093.421124993119, 6120.538559592075, 6130.141780150693, 5746.224259724883, 5774.971125144348, 5778.104393818965, 5786.392428794916, 5794.884102318014, 5702.230198923258, 5844.327902291291, 5878.088896221093, 5885.293764748258, 5890.116482527484, 5730.799422020209, 5774.335951365647, 5794.043982742969, 5799.536037116936, 5833.0, 5705.857353566194, 5708.029634961983, 5714.971425142848, 5715.657060576379, 5716.5426765859465, 5459.890802184013, 5570.972145139248, 5579.525740311957, 5636.267285252891, 5670.546356291569, 5751.827445176651, 5787.305523337226, 5792.9710351447975, 5802.506786923159, 5806.796762113306, 5629.493345598916, 5650.463205995424, 5662.7734890603915, 5668.0364338063455, 5680.77276908919], "unit": "score", "name": "dojo.html", "value": 5378.420661170004}, {"lowerIsBetter": false, "replicates": [553.79786377972, 578.1674388880012, 625.3277726444072, 638.2787450181296, 651.4723074309812, 30422.695773042262, 38311.0, 38826.22347553054, 38920.221595568146, 39052.41421378678, 41961.79019104908, 41983.58016419835, 42035.57964420355, 42259.0, 42279.154416911646, 8910.777230569256, 9004.504752238625, 9130.315226358016, 9131.497767622777, 9160.816783664322, 8775.868361974575, 8937.374383793138, 8951.597178127, 8952.641894324219, 8970.955145224265, 8863.822723545525, 8903.421277616933, 8914.108589141098, 8974.192322690957, 9017.864732029026, 8814.294856411503, 8909.68816091437, 8942.552872356357, 9092.181703646638, 9110.726678199599, 9083.273338133, 9255.537223138816, 9272.165505104573, 9284.0, 9297.395669281475, 39873.20253594941, 40234.79882600597, 40251.59748402508, 40277.0, 40315.596844031475, 3619.438986957026, 3717.4052151655605, 3717.9070523237137, 3732.5147730794824, 3771.2268984858038, 32018.519722204186, 32300.030999070066, 32508.83745581257, 32594.6740532594, 32658.0, 4038.717289789716, 4102.979485102555, 4142.2751018571935, 4157.3140431828715, 4203.0, 283222.0, 286352.0, 286642.0, 286672.0, 287064.56467717735, 46365.30452043222, 46717.532824671995, 46767.532324676315, 62843.685781571716, 63676.36323636704, 43785.343219851726, 43951.560484395384, 44234.77882610566, 44344.77827610906, 44364.55635443604, 15722.606934826721, 15897.364105435885, 16049.59876003086, 16065.839341606668, 16081.35674573004, 12720.173188742701, 12722.045846561545, 12740.554080607135, 12841.101122921305, 12872.678183045311, 15609.453669121527, 15854.9207253963, 15880.682386352208, 15927.203639817963, 15952.042877427391, 6288.968555157195, 6310.432061114522, 6318.399752023551, 6339.651319177489, 6438.3883531064475, 1044.1229367331478, 1060.2313322840878, 1103.9282446641103, 1130.1749722702473, 1134.3874307873655, 28539.57190642142, 29369.853150734536, 29377.559336609967, 29767.0, 30351.241218969262, 1146.6388087752332, 1150.6835620204342, 1200.0219820845982, 1211.2913945342073, 1245.420879291134, 15298.847011529964, 15386.230688465532, 15597.0, 15899.841001590068, 16115.516534503984, 359118.0, 509810.0, 520440.0, 522700.0, 525724.0, 54591.0, 55886.441135588124, 56010.0, 56071.0, 56138.43861561332, 1457.5335892514292, 1483.9999999999784, 1488.5459934719797, 1490.87327577155, 1500.8048953635957, 28339.433211335247, 28643.28391790222, 28665.996690115746, 28769.712302877542, 28808.279793005342, 50458.24312635387, 50481.49518504768, 50950.0, 51128.23307650314, 51165.0, 327866.0, 329955.0, 331996.0, 333642.0, 333905.0, 35259.47110793289, 46756.29865551952, 46812.29781553348, 46829.53170468388, 47756.28365574589, 43381.78309108434, 43554.78222608867, 43627.781861090494, 44037.559624403344, 44363.55636443723, 34462.0, 34613.0, 34926.65073349234, 35314.47028294629, 35606.109847254025, 37707.62292377041, 39496.696948800345, 39939.80030099831, 40093.398599021624, 40527.1894562113, 39500.80249598734, 39530.0, 39833.2033359337, 40132.59867401289, 40152.59847401606, 34387.484187737704, 34560.82719586386, 34732.65267347294, 35439.29121417609, 35605.82197088998, 27082.72917270802, 27087.86456067707, 27286.0, 27294.317642059108, 27361.31596710098], "unit": "score", "name": "ext.html", "value": 19296.610103486804}, {"lowerIsBetter": false, "replicates": [379.4251708661379, 380.65360521925055, 384.27755819060155, 385.97105217108714, 386.2834442109886, 17878.0, 18692.345767898125, 19014.524636884085, 19519.1216395262, 19797.0, 10598.894011059887, 10779.08377787889, 10781.8382724259, 14108.506202282922, 16127.113008784541, 5000.899982000358, 5211.687298762067, 5235.816746413876, 5243.842684719445, 5271.789128434858, 5217.399999000126, 5412.702301373423, 5416.160495123262, 5420.4850539198715, 5445.401005889349, 5213.374395072597, 5383.192521121824, 5404.567634589223, 5658.74535645897, 5684.772609095652, 5576.498115169654, 5598.692071936042, 5605.327360716719, 5626.043572592628, 5656.038473459522, 5226.268322434862, 5395.3525576931015, 5423.023855705971, 5635.09838425854, 5650.152477128464, 13001.869981300255, 13059.542915997894, 13117.737645247136, 13211.669708257274, 15485.845141548552, 2312.6762253284555, 2372.9762702372927, 2373.335466069503, 2380.8452450590657, 2410.8794560271917, 9293.535323233878, 10263.384196948207, 10636.627718029831, 11263.042641375492, 14055.718885622231, 1911.9044047797554, 1982.9900850495799, 2015.0932080563805, 2023.4435530229157, 2027.888466134362, 69874.0, 71016.0, 71369.28630713679, 72254.27745722528, 72501.63749181273, 10266.58933642646, 10382.480875956171, 10502.527386267484, 10527.21045921559, 10559.577616895393, 12034.699132521582, 13543.66140846467, 13556.11885227457, 13581.592552223448, 13617.727645447036, 7811.765647030598, 8070.1526339734655, 8223.05434874997, 8250.504969701837, 8296.336293096538, 8398.286145677686, 8401.36989725773, 8422.115677853859, 8480.236778689947, 8616.870746938801, 4256.170046840898, 4346.826126954949, 4386.780660966939, 4396.978015109904, 4452.977735111303, 1662.6508433228917, 1671.6322409069985, 1674.5227610131053, 1695.2286709547127, 1697.3012909473748, 1000.3947611694965, 1011.3022014809758, 1076.2143635146388, 1089.5206109311878, 1118.854548908653, 16105.838941610435, 17626.383076592516, 17699.292028318723, 18371.265149393876, 18376.356827510972, 989.2877128467492, 993.5380048277585, 1006.5319626373771, 1013.1185868294631, 1017.0897047142765, 10284.28010039305, 10351.534180961875, 10390.688279351632, 10426.635067772591, 10497.842532362021, 406209.0, 409146.0, 421114.0, 441156.0, 446279.0, 73417.26582734211, 77765.0, 78395.60802195953, 79497.0, 80105.19894800977, 1046.4610725476387, 1052.736815796051, 1068.0547715271884, 1068.2201992545486, 1075.306427354352, 15916.840831591537, 16110.677786443972, 16174.67650647004, 16317.510474685778, 16525.504234872973, 27536.586951195346, 33933.3213335727, 36117.63882361143, 36173.638263617024, 36207.275854482235, 46359.91380387823, 47321.29018064801, 47982.76008619935, 49084.75457622689, 50082.0, 11010.669679909615, 11426.600068997544, 11519.366434846164, 11609.709757256136, 11718.941405292919, 13077.346132693137, 13167.144135631153, 13251.536196233472, 13300.534481293109, 13490.392932317873, 11267.760546339732, 11452.828207576726, 11565.248258863146, 11683.415829208336, 11770.58802941893, 11371.829422558503, 11466.426678666201, 11497.482613282255, 11648.941755291507, 11718.648440546796, 11419.371934543347, 11693.12301577368, 11989.34058626784, 12086.637400877988, 12197.512099516274, 11457.541698331974, 11474.541018359172, 11589.188756787282, 11685.123615728684, 11726.296422214695, 11874.940625296818, 12014.159008869296, 12022.75954480923, 12033.0, 12088.879111209128], "unit": "score", "name": "jquery.html", "value": 8780.245945157052}, {"lowerIsBetter": false, "replicates": [1600.3438590178027, 1624.2284914665536, 1886.6792645250307, 1932.3912967415254, 1966.2036875065594, 7555.584442855641, 8383.0, 8428.620712067956, 8588.484690918549, 8601.612927418266, 8418.368622353333, 8461.53461559614, 8515.74452766418, 8529.701460448885, 8533.701320453785, 2422.9878850605764, 2436.3300092474533, 2437.171361737009, 2441.218809980807, 2464.568700477418, 2365.9171928982487, 2385.821063420242, 2390.629452434867, 2391.8445301055376, 2402.411409204747, 2406.2660888429023, 2434.4035711250767, 2441.8412803167826, 2485.092941076503, 2498.525280196766, 2456.459578892641, 2468.7778099971088, 2471.7404672509397, 2478.950420991579, 2488.4774197418565, 2425.1148330859287, 2438.1344622659053, 2440.1947357372023, 2444.669969554105, 2454.0797201049604, 8596.366690328818, 8659.220670139717, 8693.434926729742, 8700.782480437976, 8720.30237580992, 5166.586673066184, 5236.031334203147, 5236.554892834114, 5274.367075950872, 5277.815276465343, 3414.6926776590226, 3417.40195465795, 3455.0153206336327, 3551.485034669958, 3586.1572530455323, 1061.7027232374946, 1069.075249908831, 1070.7804899995483, 1074.6185104287943, 1081.1674212210228, 12017.218880772809, 12050.939745301304, 12065.33640649764, 12116.15186936906, 12160.331181784999, 4635.281531362644, 4639.744814035261, 4728.668993170445, 4739.66822322441, 4749.501302363271, 10044.397336159855, 10093.798124037477, 10122.240831937486, 10122.949385253027, 10127.898721012696, 5232.843014709489, 5243.134882744304, 5268.894622107613, 5279.498447647467, 5308.761105750251, 4231.767252801125, 4669.0, 4744.454387745384, 4761.0, 4798.856034318976, 3921.9803900980883, 4036.192761447722, 4067.654249388776, 4077.3068578341754, 4111.5477297497255, 1242.316725800806, 1304.3347892574855, 1314.3231235913513, 1319.4326439630859, 1330.1885849631717, 1467.6330917270682, 1484.1985327923016, 1491.843356447579, 1493.9701205975819, 1504.1877386211543, 8159.67361305553, 8164.061132969666, 8194.426390152632, 8200.0, 8222.38332125093, 485.3956823754378, 492.990140197194, 495.23486213799765, 495.6431369414016, 498.2451585847444, 6247.406496382836, 6277.654728989949, 6284.842878927972, 6286.811395658137, 6299.1811064562235, 9977.650782222587, 10162.745931351776, 10179.898201018043, 10211.0, 10321.690349289533, 10037.146842518321, 10051.24615653829, 10084.798304033879, 10112.544935477921, 10160.695179144637, 7879.763607091796, 8116.0, 8117.8376432472205, 8142.837143257102, 8191.7712343149005, 7604.733834315773, 7762.689492420466, 7842.686292548234, 7856.25365590268, 7860.449768516149, 9141.817163656557, 9233.769155771159, 9244.768880778034, 9376.765580860532, 9584.712458626253, 8970.506622135845, 9234.261259099121, 9587.280953928623, 9595.184409325286, 9658.517074146124, 7894.21057894206, 8039.437239393186, 8064.758057258292, 8085.353171746364, 8265.380096492667, 8189.79525511867, 8222.506649601042, 8291.751247462586, 8318.750437486886, 8333.374996875138, 7413.518121322097, 7496.7750967471065, 7501.362384197404, 7570.091589009354, 7682.154962954182, 7317.634118294171, 7445.181030086795, 7516.0, 7582.734604288823, 7716.074071111502, 7845.0585929688805, 7889.368850492062, 7941.285284324438, 7947.682092716226, 7962.681492740226, 7023.789286321418, 7081.291870812877, 7331.0, 7346.412287017132, 7349.0, 7241.5293005954445, 7300.817479563053, 7302.817429564303, 7312.597807120659, 7337.26627337262], "unit": "score", "name": "mootools.html", "value": 4844.0935861450935}, {"lowerIsBetter": false, "replicates": [332.68893584498494, 334.58678532012976, 336.5339005477414, 337.886807919347, 344.2821716720637, 6310.305866354703, 6336.334684858092, 6341.270753863307, 6374.904376434351, 6385.138006369139, 6277.1839660844025, 6349.238091429023, 6349.238091429035, 6360.204974378203, 6378.808635740936, 4635.490096089427, 4705.882352941169, 4743.857684269477, 4754.595859351959, 4823.517648235174, 4720.268358404435, 4748.406449193851, 4751.21604935187, 4764.97617511912, 4786.042791441708, 4679.953200468003, 4754.120487709767, 4758.571728544431, 4762.1428142934255, 4770.833020844271, 4721.362616046824, 4755.072760811643, 4756.9286460703115, 4775.689580177277, 4778.331033655291, 4103.076807718269, 4107.527634322061, 4108.4453598764085, 4139.648129908961, 4142.130152667944, 6016.127661489059, 6067.150598916155, 6069.484093852028, 6075.119107729354, 6081.422264884829, 5355.7857685692525, 5515.145152501369, 5516.586256030814, 5531.612787104904, 5535.39110697827, 6515.70679319427, 6629.767958121491, 6629.93370066298, 6654.567453115532, 6670.3329667033395, 4520.254158063915, 4520.254158063948, 4528.660350473728, 4532.818687252506, 4537.9773101134615, 6960.617166055865, 7000.544964577337, 7028.75399361025, 7044.154701435809, 7055.964720176417, 4494.977525112419, 4551.52209018055, 4601.28680054592, 4625.838095666702, 4642.582167604932, 4710.788014539354, 4714.339992401066, 4716.575508204278, 4717.95282047182, 4725.125851717443, 5520.889582208413, 5521.1442226454965, 5531.197976293495, 5534.280543529316, 5549.417311182348, 6737.0, 6763.458923286125, 6764.864702705919, 6770.119884415093, 6775.966120169368, 1616.4908053962963, 1646.6212771062724, 1663.6173680053655, 1664.184549570726, 1668.6495835874603, 1079.3038490173794, 1080.4381721504774, 1083.344576531203, 1086.5545126498098, 1097.0839349143396, 6451.483881289486, 6468.579542329733, 6493.902591461132, 6500.804975850732, 6516.641584712792, 6891.689873955684, 6909.7581584644295, 6911.343422374866, 6918.0, 6929.896051559231, 6448.355164483608, 6463.741450341934, 6466.612003279818, 6486.286508484063, 6501.284858665543, 3722.925541489209, 3725.385311423639, 3729.8135093245774, 3756.69946404287, 3762.9623703762613, 7141.250168732312, 7342.229065947999, 7364.594947277951, 7379.963100184572, 7386.4829461938225, 7266.273372662798, 7268.345848873627, 7275.745348912763, 7290.052293201956, 7310.52481588695, 7219.241979592172, 7266.854662906818, 7276.1996180419055, 7306.525075870051, 7312.268773122752, 6969.756058537927, 7101.786946391617, 7102.964485177541, 7107.715691372287, 7109.3601575856355, 6918.757843475454, 6929.099217101744, 6934.133233345832, 6950.4787140965645, 7006.2643422439905, 7287.12554493443, 7331.963340183265, 7341.6329183541675, 7349.448791340564, 7352.301531354513, 4595.977020114878, 4620.0528891577815, 4624.514425985223, 4633.397658304399, 4644.674872759009, 6910.792676219721, 7022.578645281299, 7033.226345101933, 7067.116610423697, 7081.398081163159, 6829.112215412163, 6876.96845473183, 6892.965535172292, 6894.586324820527, 6897.448204143757, 6856.588604683735, 6870.45036397097, 6876.69054892541, 6885.242623311332, 6885.965570172117, 6741.2921643226755, 6752.257251702211, 6763.357481039294, 6768.526203165928, 6777.966110169417, 6727.596344219362, 6881.827954301182, 6896.655167241517, 6914.4468442525485, 6922.7923162305215, 6696.263411024881, 6734.528582999143, 6738.090357801634, 6742.932570674427, 6751.156105486814], "unit": "score", "name": "prototype.html", "value": 5051.857202037844}, {"lowerIsBetter": false, "replicates": [718.5904034700217, 728.4463807506294, 784.5488843914749, 870.4298684361742, 891.9286457083434, 17117.40089096882, 17315.134243287815, 17438.73841892371, 17515.474535763915, 17522.29910803568, 16040.518784436457, 16091.758623620655, 16143.515694529153, 16188.514344569652, 16257.674846503063, 896.4307664632972, 918.191991047877, 919.6275508419068, 934.3319526538523, 955.6225291010081, 934.7990182110844, 944.1549812917435, 944.2776276148752, 951.0632027452954, 951.8143961927427, 969.1084202533651, 979.745266230778, 979.9951000244989, 980.5195454227448, 983.9754006149832, 961.6874515782399, 966.0001898035534, 966.4732720667254, 969.767255858596, 970.034815358719, 712.2592503796046, 715.4848509073511, 718.4073139659802, 719.2950908110029, 719.6114098386864, 15665.530034098882, 15690.450834220748, 15747.055176689435, 15876.761848572281, 15888.443904463289, 13784.655383615389, 14080.436782528686, 14204.573862784133, 14306.141631502143, 14346.282685865664, 11873.881261187364, 11901.047916166686, 11904.761904761943, 12044.0, 12228.0, 3917.4319723639915, 3955.1694144229746, 4050.8379664813374, 4052.1895620875944, 4065.125997910434, 49203.75398123022, 49355.50644493581, 49564.0, 49756.50243497591, 49767.502324976645, 11486.253393529394, 11525.76948461026, 11646.24299420535, 11762.059035277158, 11901.464434100486, 19681.803181967996, 19926.800731992495, 20090.296839610543, 20102.296419625243, 20121.899390503248, 8355.7266141858, 8416.0, 8573.09982451846, 8608.053114157437, 8703.086175951561, 4849.151398505247, 4854.296127061627, 4863.683860549053, 4976.278439626234, 5026.09530284545, 3389.9152521187166, 3408.4716868884866, 3418.0258626291884, 3424.760266781301, 3436.3642726095754, 663.6416335178949, 666.2804171494774, 669.0699927101333, 672.3175976383974, 673.7574473189648, 694.0630149298406, 714.589111261027, 754.1930134755759, 755.8374949385799, 760.4942713095729, 9014.909850901538, 9151.67969121091, 9181.311401644904, 9192.95403522978, 9303.58133883977, 610.9327973922865, 621.7730528357117, 631.2961048431058, 635.8481689652592, 702.7786247332074, 4197.265478541243, 4235.4917409911, 4284.67864910133, 4298.075913678512, 4434.933475997863, 60449.39550604526, 60502.69748651316, 61312.693436533424, 61948.0, 62027.37972620216, 54280.728596357556, 55079.0, 55792.442075579536, 55795.44204557984, 55906.0, 50030.49969500331, 50290.74854625703, 51226.487735122915, 51433.74283128561, 52538.0, 8526.0, 8683.044865064965, 8838.911610884066, 8839.911600883908, 8956.23029173202, 36913.0, 37426.8128659355, 37542.624573755005, 38534.42198367083, 38712.80643596764, 43584.34623480714, 45567.0, 46927.76536117298, 48041.27938080861, 48442.273365898836, 10841.18691098155, 11965.461554229907, 12064.45709943037, 12153.0, 12206.633800985985, 13483.05618606688, 13535.86464135346, 13692.589222323346, 14018.439262429796, 14413.711725765635, 12237.082218833444, 12662.303573303558, 12676.366181690693, 12680.23918564889, 12838.229706217657, 12341.814872777095, 12759.298238596595, 13233.86766132365, 13286.402111904794, 13299.0, 12356.567520137112, 12494.68763280889, 12655.240685558896, 12781.360931953552, 12980.221186728826, 10345.534450949875, 10649.733756656145, 10746.194035447217, 11096.278741881752, 11224.382658953837, 10860.728481788019, 10958.397288149228, 10962.835557466486, 11036.227464077438, 11110.944445277722], "unit": "score", "name": "yui.html", "value": 7035.409035404691}], "name": "dromaeo_css", "value": 7344.097662091395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 103.0, 110.0, 110.0, 112.0, 123.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 153.0, 163.0, 129.0, 162.0, 147.0, 129.0, 163.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 161.0, 160.0, 160.0, 161.0, 162.0, 163.0, 163.0, 167.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 163.0, 74.0, 76.0, 76.0, 73.0, 156.0, 78.0], "unit": "score", "name": "audio-fft", "value": 92.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 142.0, 92.0, 93.0, 92.0, 145.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 153.0, 149.0, 150.0, 149.0, 146.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 59.0, 56.0, 57.0, 70.0, 60.0, 64.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 71.0, 72.0, 72.0, 72.0, 73.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.8}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 81.0, 82.0, 80.0, 82.0, 90.0, 79.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [115.0, 123.0, 111.0, 123.0, 114.0, 111.0, 118.0, 116.0, 116.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [141.0, 148.0, 153.0, 146.0, 147.0, 149.0, 149.0, 151.0, 148.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 71.0, 65.0, 72.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1524.5999999999997}]} 09:33:31 INFO - Return code: 0 09:33:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:33:31 ERROR - # TBPL SUCCESS # 09:33:31 INFO - Running post-action listener: _resource_record_post_action 09:33:31 INFO - Running post-run listener: _resource_record_post_run 09:33:32 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250122240; Read time: 12; Write time: 150084 09:33:32 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5754880; Read time: 0; Write time: 476 09:33:32 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 244367360; Read time: 12; Write time: 149608 09:33:32 INFO - Running post-run listener: _upload_blobber_files 09:33:32 INFO - Blob upload gear active. 09:33:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:33:32 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 09:33:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:33:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:33:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:33 INFO - (blobuploader) - INFO - Done attempting. 09:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:33:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:34 INFO - (blobuploader) - INFO - Done attempting. 09:33:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:34 INFO - Return code: 0 09:33:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:33:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1b8199f0d06dc1033043189a807c07e426cde5dbfa9ea0c0d9eed7295352665be029e90af256f85f745370b4395a60cef6011b126ece632d5c8f79f309a2e15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d995952122fe8df1a178cf38d1ed19725d19932cbe1a8640441c1f4fa2e250556c17d2ceb9d1129d53f4bfc79daaa098a4498348123f22f32fd23aea9c9258a"} 09:33:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:33:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:33:34 INFO - Contents: 09:33:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1b8199f0d06dc1033043189a807c07e426cde5dbfa9ea0c0d9eed7295352665be029e90af256f85f745370b4395a60cef6011b126ece632d5c8f79f309a2e15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d995952122fe8df1a178cf38d1ed19725d19932cbe1a8640441c1f4fa2e250556c17d2ceb9d1129d53f4bfc79daaa098a4498348123f22f32fd23aea9c9258a"} 09:33:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:34 INFO - Copying logs to upload dir... 09:33:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:33:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1303.913282 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-03-24 09:33:33.630517) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 09:33:33.635057) ========= 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1b8199f0d06dc1033043189a807c07e426cde5dbfa9ea0c0d9eed7295352665be029e90af256f85f745370b4395a60cef6011b126ece632d5c8f79f309a2e15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d995952122fe8df1a178cf38d1ed19725d19932cbe1a8640441c1f4fa2e250556c17d2ceb9d1129d53f4bfc79daaa098a4498348123f22f32fd23aea9c9258a"} build_url:https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011482 build_url: 'https://queue.taskcluster.net/v1/task/YGLM-FgBRhqzBJt5p7Mpgg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1b8199f0d06dc1033043189a807c07e426cde5dbfa9ea0c0d9eed7295352665be029e90af256f85f745370b4395a60cef6011b126ece632d5c8f79f309a2e15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d995952122fe8df1a178cf38d1ed19725d19932cbe1a8640441c1f4fa2e250556c17d2ceb9d1129d53f4bfc79daaa098a4498348123f22f32fd23aea9c9258a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 09:33:33.664349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:33:33.664683) ========= 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=3a3620fb28aea1604ab609ef000001d2-1458835622.265707-1954118917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 09:33:33.749222) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 09:33:33.749550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 09:33:33.749872) ========= ========= Total master_lag: 0.53 =========