builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1456391597.22 results: success (0) buildid: 20160224223120 builduid: bba28e4715644b3c9900d1ee56824527 revision: 1f797f47e312c4ab9883bd48c9e3501619ff9e95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.216672) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.217149) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.217515) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.237017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.240375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.253741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.254050) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004675 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.308076) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.308431) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.308825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.309136) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 01:13:17-- 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% 76.4M=0s 2016-02-25 01:13:17 (76.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.489103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.489470) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023106 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.541360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:17.542192) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1f797f47e312c4ab9883bd48c9e3501619ff9e95 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1f797f47e312c4ab9883bd48c9e3501619ff9e95 --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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 01:13:17,952 truncating revision to first 12 chars 2016-02-25 01:13:17,952 Setting DEBUG logging. 2016-02-25 01:13:17,952 attempt 1/10 2016-02-25 01:13:17,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1f797f47e312?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 01:13:18,243 unpacking tar archive at: mozilla-inbound-1f797f47e312/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:18.152371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:18.153167) ========= echo 1f797f47e312c4ab9883bd48c9e3501619ff9e95 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1f797f47e312c4ab9883bd48c9e3501619ff9e95'] 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1f797f47e312c4ab9883bd48c9e3501619ff9e95 program finished with exit code 0 elapsedTime=0.004601 script_repo_revision: '1f797f47e312c4ab9883bd48c9e3501619ff9e95' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:18.205125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:18.205469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 01:13:18.215376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-25 01:13:18.215686) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:13:18 INFO - MultiFileLogger online at 20160225 01:13:18 in /builds/slave/test-pgo 01:13:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:13:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:13:18 INFO - {'append_to_log': False, 01:13:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:13:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:13:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:13:18 INFO - 'branch': 'Mozilla-Inbound', 01:13:18 INFO - 'buildbot_json_path': 'buildprops.json', 01:13:18 INFO - 'config_files': ('talos/linux_config.py',), 01:13:18 INFO - 'default_actions': ('clobber', 01:13:18 INFO - 'read-buildbot-config', 01:13:18 INFO - 'download-and-extract', 01:13:18 INFO - 'populate-webroot', 01:13:18 INFO - 'create-virtualenv', 01:13:18 INFO - 'install', 01:13:18 INFO - 'run-tests'), 01:13:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:13:18 INFO - 'download_minidump_stackwalk': True, 01:13:18 INFO - 'download_symbols': 'ondemand', 01:13:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:13:18 INFO - 'tooltool.py': '/tools/tooltool.py', 01:13:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:13:18 INFO - '/tools/misc-python/virtualenv.py')}, 01:13:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:13:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:13:18 INFO - 'installer_path': 'installer.exe', 01:13:18 INFO - 'log_level': 'info', 01:13:18 INFO - 'log_name': 'talos', 01:13:18 INFO - 'log_to_console': True, 01:13:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:13:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:13:18 INFO - 'opt_config_files': (), 01:13:18 INFO - 'pip_index': False, 01:13:18 INFO - 'sps_profile': False, 01:13:18 INFO - 'sps_profile_interval': 0, 01:13:18 INFO - 'suite': 'dromaeojs', 01:13:18 INFO - 'system_bits': '32', 01:13:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:13:18 INFO - 'title': 'talos-linux64-ix-007', 01:13:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:13:18 INFO - 'use_talos_json': True, 01:13:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:13:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:13:18 INFO - 'work_dir': 'build'} 01:13:18 INFO - ##### 01:13:18 INFO - ##### Running clobber step. 01:13:18 INFO - ##### 01:13:18 INFO - Running pre-action listener: _resource_record_pre_action 01:13:18 INFO - Running main action method: clobber 01:13:18 INFO - rmtree: /builds/slave/test-pgo/build 01:13:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:13:19 INFO - Running post-action listener: _resource_record_post_action 01:13:19 INFO - ##### 01:13:19 INFO - ##### Running read-buildbot-config step. 01:13:19 INFO - ##### 01:13:19 INFO - Running pre-action listener: _resource_record_pre_action 01:13:19 INFO - Running main action method: read_buildbot_config 01:13:19 INFO - Using buildbot properties: 01:13:19 INFO - { 01:13:19 INFO - "project": "", 01:13:19 INFO - "product": "firefox", 01:13:19 INFO - "script_repo_revision": "production", 01:13:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:13:19 INFO - "repository": "", 01:13:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:13:19 INFO - "buildid": "20160224223120", 01:13:19 INFO - "pgo_build": "True", 01:13:19 INFO - "basedir": "/builds/slave/test-pgo", 01:13:19 INFO - "buildnumber": 716, 01:13:19 INFO - "slavename": "talos-linux64-ix-007", 01:13:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:13:19 INFO - "platform": "ubuntu64_hw", 01:13:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:13:19 INFO - "branch": "mozilla-inbound", 01:13:19 INFO - "repo_path": "integration/mozilla-inbound", 01:13:19 INFO - "revision": "1f797f47e312c4ab9883bd48c9e3501619ff9e95", 01:13:19 INFO - "stage_platform": "linux64-pgo", 01:13:19 INFO - "builduid": "bba28e4715644b3c9900d1ee56824527", 01:13:19 INFO - "slavebuilddir": "test" 01:13:19 INFO - } 01:13:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 01:13:19 INFO - Running post-action listener: _resource_record_post_action 01:13:19 INFO - ##### 01:13:19 INFO - ##### Running download-and-extract step. 01:13:19 INFO - ##### 01:13:19 INFO - Running pre-action listener: _resource_record_pre_action 01:13:19 INFO - Running main action method: download_and_extract 01:13:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:19 INFO - https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:13:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/test_packages.json 01:13:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/test_packages.json 01:13:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:13:19 INFO - Downloaded 1448 bytes. 01:13:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:13:19 INFO - Using the following test package requirements: 01:13:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:13:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:13:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'jsshell-linux-x86_64.zip'], 01:13:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:13:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:13:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:13:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:13:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:13:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:19 INFO - https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:13:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:13:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:13:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:13:20 INFO - Downloaded 23369840 bytes. 01:13:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:13:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:13:22 INFO - Return code: 0 01:13:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:13:22 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')]} 01:13:22 INFO - https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:13:23 INFO - Downloaded 23369840 bytes. 01:13:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:13:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:13:24 INFO - Return code: 0 01: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')]} 01:13:24 INFO - https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:13:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:13:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:13:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:13:25 INFO - Downloaded 10707015 bytes. 01:13:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:13:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:13:25 INFO - Return code: 0 01:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:25 INFO - https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:13:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:13:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:13:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:13:27 INFO - Downloaded 56582901 bytes. 01:13:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:13:27 INFO - mkdir: /builds/slave/test-pgo/properties 01:13:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:13:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:13:27 INFO - Contents: 01:13:27 INFO - build_url:https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:13:27 INFO - Running post-action listener: _resource_record_post_action 01:13:27 INFO - Running post-action listener: set_extra_try_arguments 01:13:27 INFO - ##### 01:13:27 INFO - ##### Running populate-webroot step. 01:13:27 INFO - ##### 01:13:27 INFO - Running pre-action listener: _resource_record_pre_action 01:13:27 INFO - Running main action method: populate_webroot 01:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:13:27 INFO - '--tppagecycles', 01:13:27 INFO - '7'], 01:13:27 INFO - 'tests': ['tsvgm']}}, 01:13:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:13:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:13:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:13:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:13:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:13:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:13:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'tests': ['damp', 'tps']}, 01:13:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['damp', 'tps']}, 01:13:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:13:27 INFO - 'other': {'tests': ['a11yr', 01:13:27 INFO - 'ts_paint', 01:13:27 INFO - 'tpaint', 01:13:27 INFO - 'sessionrestore', 01:13:27 INFO - 'sessionrestore_no_auto_restore']}, 01:13:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['a11yr', 01:13:27 INFO - 'ts_paint', 01:13:27 INFO - 'tpaint', 01:13:27 INFO - 'sessionrestore', 01:13:27 INFO - 'sessionrestore_no_auto_restore']}, 01:13:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['a11yr', 01:13:27 INFO - 'ts_paint', 01:13:27 INFO - 'tpaint', 01:13:27 INFO - 'sessionrestore', 01:13:27 INFO - 'sessionrestore_no_auto_restore']}, 01:13:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['a11yr', 01:13:27 INFO - 'ts_paint', 01:13:27 INFO - 'tpaint', 01:13:27 INFO - 'sessionrestore', 01:13:27 INFO - 'sessionrestore_no_auto_restore']}, 01:13:27 INFO - 'other_l64': {'tests': ['a11yr', 01:13:27 INFO - 'ts_paint', 01:13:27 INFO - 'tpaint', 01:13:27 INFO - 'sessionrestore', 01:13:27 INFO - 'sessionrestore_no_auto_restore']}, 01:13:27 INFO - 'other_nol64': {'tests': ['a11yr', 01:13:27 INFO - 'ts_paint', 01:13:27 INFO - 'tpaint', 01:13:27 INFO - 'sessionrestore', 01:13:27 INFO - 'sessionrestore_no_auto_restore']}, 01:13:27 INFO - 'svgr': {'tests': ['tsvgx', 01:13:27 INFO - 'tsvgr_opacity', 01:13:27 INFO - 'tart', 01:13:27 INFO - 'tscrollx', 01:13:27 INFO - 'cart']}, 01:13:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['tsvgx', 01:13:27 INFO - 'tsvgr_opacity', 01:13:27 INFO - 'tart', 01:13:27 INFO - 'tscrollx', 01:13:27 INFO - 'cart']}, 01:13:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'tests': ['tp5o']}, 01:13:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'talos_options': ['--e10s'], 01:13:27 INFO - 'tests': ['tp5o']}, 01:13:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'talos_options': ['--xperf_path', 01:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:13:27 INFO - 'tests': ['tp5n']}, 01:13:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:27 INFO - 'talos_options': ['--e10s', 01:13:27 INFO - '--xperf_path', 01:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:13:27 INFO - 'tests': ['tp5n']}}, 01:13:27 INFO - 'talos.zip': {'path': '', 01:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:13:27 INFO - Running post-action listener: _resource_record_post_action 01:13:27 INFO - ##### 01:13:27 INFO - ##### Running create-virtualenv step. 01:13:27 INFO - ##### 01:13:27 INFO - Running pre-action listener: _resource_record_pre_action 01:13:27 INFO - Running main action method: create_virtualenv 01:13:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:13:27 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 01:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:13:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:13:27 INFO - Using real prefix '/usr' 01:13:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:13:28 INFO - Installing distribute.............................................................................................................................................................................................done. 01:13:30 INFO - Installing pip.................done. 01:13:30 INFO - Return code: 0 01:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:30 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:30 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 01:13:30 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 01:13:30 INFO - Using env: {'DISPLAY': ':0', 01:13:30 INFO - 'HOME': '/home/cltbld', 01:13:30 INFO - 'LANG': 'en_US.UTF-8', 01:13:30 INFO - 'LANGUAGE': 'en_US:en', 01:13:30 INFO - 'LOGNAME': 'cltbld', 01:13:30 INFO - 'MAIL': '/var/mail/cltbld', 01:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:30 INFO - 'MOZ_NO_REMOTE': '1', 01:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:30 INFO - 'NO_EM_RESTART': '1', 01:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:30 INFO - 'SHELL': '/bin/bash', 01:13:30 INFO - 'SHLVL': '1', 01:13:30 INFO - 'TERM': 'linux', 01:13:30 INFO - 'TMOUT': '86400', 01:13:30 INFO - 'USER': 'cltbld', 01:13:30 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:30 INFO - '_': '/tools/buildbot/bin/python'} 01:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:30 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 01:13:30 INFO - Cleaning up... 01:13:30 INFO - Return code: 0 01:13:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:30 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:30 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 01:13:30 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 01:13:30 INFO - Using env: {'DISPLAY': ':0', 01:13:30 INFO - 'HOME': '/home/cltbld', 01:13:30 INFO - 'LANG': 'en_US.UTF-8', 01:13:30 INFO - 'LANGUAGE': 'en_US:en', 01:13:30 INFO - 'LOGNAME': 'cltbld', 01:13:30 INFO - 'MAIL': '/var/mail/cltbld', 01:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:30 INFO - 'MOZ_NO_REMOTE': '1', 01:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:30 INFO - 'NO_EM_RESTART': '1', 01:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:30 INFO - 'SHELL': '/bin/bash', 01:13:30 INFO - 'SHLVL': '1', 01:13:30 INFO - 'TERM': 'linux', 01:13:30 INFO - 'TMOUT': '86400', 01:13:30 INFO - 'USER': 'cltbld', 01:13:30 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:30 INFO - '_': '/tools/buildbot/bin/python'} 01:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:30 INFO - Downloading/unpacking psutil>=0.7.1 01:13:30 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 01:13:30 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 01:13:30 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 01:13:30 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 01:13:30 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 01:13:30 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 01:13:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:32 INFO - Installing collected packages: psutil 01:13:32 INFO - Running setup.py install for psutil 01:13:32 INFO - building 'psutil._psutil_linux' extension 01:13:32 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 01:13:33 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 01:13:33 INFO - building 'psutil._psutil_posix' extension 01:13:33 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 01:13:33 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 01:13:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:33 INFO - Successfully installed psutil 01:13:33 INFO - Cleaning up... 01:13:33 INFO - Return code: 0 01:13:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01: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')]} 01:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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', '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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01: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 mozsystemmonitor==0.0.0 01:13:33 INFO - Using env: {'DISPLAY': ':0', 01:13:33 INFO - 'HOME': '/home/cltbld', 01:13:33 INFO - 'LANG': 'en_US.UTF-8', 01:13:33 INFO - 'LANGUAGE': 'en_US:en', 01:13:33 INFO - 'LOGNAME': 'cltbld', 01:13:33 INFO - 'MAIL': '/var/mail/cltbld', 01:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:33 INFO - 'MOZ_NO_REMOTE': '1', 01:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:33 INFO - 'NO_EM_RESTART': '1', 01:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:33 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:33 INFO - 'SHELL': '/bin/bash', 01:13:33 INFO - 'SHLVL': '1', 01:13:33 INFO - 'TERM': 'linux', 01:13:33 INFO - 'TMOUT': '86400', 01:13:33 INFO - 'USER': 'cltbld', 01:13:33 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:33 INFO - '_': '/tools/buildbot/bin/python'} 01:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:13:33 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 01:13:33 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 01:13:33 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 01:13:33 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 01:13:33 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 01:13:33 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 01:13:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:13:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:13:35 INFO - Installing collected packages: mozsystemmonitor 01:13:35 INFO - Running setup.py install for mozsystemmonitor 01:13:35 INFO - Successfully installed mozsystemmonitor 01:13:35 INFO - Cleaning up... 01:13:35 INFO - Return code: 0 01:13:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:13:35 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')]} 01:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:35 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')]} 01:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:35 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:35 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 01:13:35 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 01:13:35 INFO - Using env: {'DISPLAY': ':0', 01:13:35 INFO - 'HOME': '/home/cltbld', 01:13:35 INFO - 'LANG': 'en_US.UTF-8', 01:13:35 INFO - 'LANGUAGE': 'en_US:en', 01:13:35 INFO - 'LOGNAME': 'cltbld', 01:13:35 INFO - 'MAIL': '/var/mail/cltbld', 01:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:35 INFO - 'MOZ_NO_REMOTE': '1', 01:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:35 INFO - 'NO_EM_RESTART': '1', 01:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:35 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:35 INFO - 'SHELL': '/bin/bash', 01:13:35 INFO - 'SHLVL': '1', 01:13:35 INFO - 'TERM': 'linux', 01:13:35 INFO - 'TMOUT': '86400', 01:13:35 INFO - 'USER': 'cltbld', 01:13:35 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:35 INFO - '_': '/tools/buildbot/bin/python'} 01:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:35 INFO - Downloading/unpacking blobuploader==1.2.4 01:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:37 INFO - Downloading blobuploader-1.2.4.tar.gz 01:13:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:13:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:13:37 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 01:13:37 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 01:13:37 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 01:13:37 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 01:13:37 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 01:13:37 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 01:13:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:13:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01: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 01: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 01: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 01: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 01: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 01: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 01:13:38 INFO - Downloading docopt-0.6.1.tar.gz 01:13:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:13:38 INFO - Installing collected packages: blobuploader, requests, docopt 01:13:38 INFO - Running setup.py install for blobuploader 01:13:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:13:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:13:38 INFO - Running setup.py install for requests 01:13:38 INFO - Running setup.py install for docopt 01:13:38 INFO - Successfully installed blobuploader requests docopt 01:13:38 INFO - Cleaning up... 01:13:39 INFO - Return code: 0 01:13:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01: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')]} 01:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:39 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:39 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 01:13:39 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 01:13:39 INFO - Using env: {'DISPLAY': ':0', 01:13:39 INFO - 'HOME': '/home/cltbld', 01:13:39 INFO - 'LANG': 'en_US.UTF-8', 01:13:39 INFO - 'LANGUAGE': 'en_US:en', 01:13:39 INFO - 'LOGNAME': 'cltbld', 01:13:39 INFO - 'MAIL': '/var/mail/cltbld', 01:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:39 INFO - 'MOZ_NO_REMOTE': '1', 01:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:39 INFO - 'NO_EM_RESTART': '1', 01:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:39 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:39 INFO - 'SHELL': '/bin/bash', 01:13:39 INFO - 'SHLVL': '1', 01:13:39 INFO - 'TERM': 'linux', 01:13:39 INFO - 'TMOUT': '86400', 01:13:39 INFO - 'USER': 'cltbld', 01:13:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:39 INFO - '_': '/tools/buildbot/bin/python'} 01:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:13:39 INFO - Running setup.py (path:/tmp/pip-a4SYmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:13:39 INFO - Running setup.py (path:/tmp/pip-p6XD_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:13:39 INFO - Running setup.py (path:/tmp/pip-NFmHTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:13:39 INFO - Running setup.py (path:/tmp/pip-2fusvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:13:39 INFO - Running setup.py (path:/tmp/pip-AN1I6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:13:39 INFO - Running setup.py (path:/tmp/pip-RVZapg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:13:39 INFO - Running setup.py (path:/tmp/pip-pMyfYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:13:39 INFO - Running setup.py (path:/tmp/pip-afSc1Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:13:39 INFO - Running setup.py (path:/tmp/pip-iKAw2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:13:39 INFO - Running setup.py (path:/tmp/pip-zMEGMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:13:40 INFO - Running setup.py (path:/tmp/pip-r8pysg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:13:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:13:40 INFO - Running setup.py (path:/tmp/pip-Vt6bAV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:13:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:13:40 INFO - Running setup.py (path:/tmp/pip-83vc0J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:13:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:13:40 INFO - Running setup.py (path:/tmp/pip-R7RwiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:13:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:13:40 INFO - Running setup.py (path:/tmp/pip-qhEKgk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:13:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:13:40 INFO - Running setup.py (path:/tmp/pip-CNaFS4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:13:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:13:40 INFO - Running setup.py (path:/tmp/pip-IH7C09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:13:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:13:40 INFO - Running setup.py install for manifestparser 01:13:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:13:40 INFO - Running setup.py install for mozcrash 01:13:40 INFO - Running setup.py install for mozdebug 01:13:40 INFO - Running setup.py install for mozdevice 01:13:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:13:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:13:40 INFO - Running setup.py install for mozfile 01:13:41 INFO - Running setup.py install for mozhttpd 01:13:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for mozinfo 01:13:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for mozInstall 01:13:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for mozleak 01:13:41 INFO - Running setup.py install for mozlog 01:13:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for moznetwork 01:13:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for mozprocess 01:13:41 INFO - Running setup.py install for mozprofile 01:13:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for mozrunner 01:13:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:13:41 INFO - Running setup.py install for mozscreenshot 01:13:42 INFO - Running setup.py install for moztest 01:13:42 INFO - Running setup.py install for mozversion 01:13:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:13:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:13:42 INFO - Cleaning up... 01:13:42 INFO - Return code: 0 01:13:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:42 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:42 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 01:13:42 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 01:13:42 INFO - Using env: {'DISPLAY': ':0', 01:13:42 INFO - 'HOME': '/home/cltbld', 01:13:42 INFO - 'LANG': 'en_US.UTF-8', 01:13:42 INFO - 'LANGUAGE': 'en_US:en', 01:13:42 INFO - 'LOGNAME': 'cltbld', 01:13:42 INFO - 'MAIL': '/var/mail/cltbld', 01:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:42 INFO - 'MOZ_NO_REMOTE': '1', 01:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:42 INFO - 'NO_EM_RESTART': '1', 01:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:42 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:42 INFO - 'SHELL': '/bin/bash', 01:13:42 INFO - 'SHLVL': '1', 01:13:42 INFO - 'TERM': 'linux', 01:13:42 INFO - 'TMOUT': '86400', 01:13:42 INFO - 'USER': 'cltbld', 01:13:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:42 INFO - '_': '/tools/buildbot/bin/python'} 01:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:13:42 INFO - Running setup.py (path:/tmp/pip-ddUmMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:13:42 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)) 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:13:42 INFO - Running setup.py (path:/tmp/pip-oW5Xwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:13:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:13:42 INFO - Running setup.py (path:/tmp/pip-zdAFMC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:13:42 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)) 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:13:42 INFO - Running setup.py (path:/tmp/pip-FNBN5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:13:42 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)) 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:13:42 INFO - Running setup.py (path:/tmp/pip-1TAfSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:13:42 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)) 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:13:42 INFO - Running setup.py (path:/tmp/pip-L3B2fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:13:42 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)) 01:13:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:13:42 INFO - Running setup.py (path:/tmp/pip-AlDpat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:13:43 INFO - Running setup.py (path:/tmp/pip-a8MdKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:13:43 INFO - Running setup.py (path:/tmp/pip-cdU5gp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:13:43 INFO - Running setup.py (path:/tmp/pip-bCzAt1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:13:43 INFO - Running setup.py (path:/tmp/pip-zEAfmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:13:43 INFO - Running setup.py (path:/tmp/pip-J1cDD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:13:43 INFO - Running setup.py (path:/tmp/pip-fpnxpJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:13:43 INFO - Running setup.py (path:/tmp/pip-8oK1wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:13:43 INFO - Running setup.py (path:/tmp/pip-xwDt4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:13:43 INFO - Running setup.py (path:/tmp/pip-TkYpVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:13:43 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)) 01:13:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:13:43 INFO - Running setup.py (path:/tmp/pip-fjpboV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:13:43 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)) 01:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:13:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:13:43 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)) 01:13:43 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)) 01:13:43 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)) 01:13:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01: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 01: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 01: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 01: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 01: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 01: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 01:13:45 INFO - Downloading blessings-1.6.tar.gz 01:13:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:13:45 INFO - Installing collected packages: blessings 01:13:45 INFO - Running setup.py install for blessings 01:13:45 INFO - Successfully installed blessings 01:13:45 INFO - Cleaning up... 01:13:45 INFO - Return code: 0 01:13:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:13:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:13:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:13:46 INFO - Reading from file tmpfile_stdout 01:13:46 INFO - Current package versions: 01:13:46 INFO - argparse == 1.2.1 01:13:46 INFO - blessings == 1.6 01:13:46 INFO - blobuploader == 1.2.4 01:13:46 INFO - docopt == 0.6.1 01:13:46 INFO - manifestparser == 1.1 01:13:46 INFO - mozInstall == 1.12 01:13:46 INFO - mozcrash == 0.16 01:13:46 INFO - mozdebug == 0.1 01:13:46 INFO - mozdevice == 0.48 01:13:46 INFO - mozfile == 1.2 01:13:46 INFO - mozhttpd == 0.7 01:13:46 INFO - mozinfo == 0.9 01:13:46 INFO - mozleak == 0.1 01:13:46 INFO - mozlog == 3.1 01:13:46 INFO - moznetwork == 0.27 01:13:46 INFO - mozprocess == 0.22 01:13:46 INFO - mozprofile == 0.28 01:13:46 INFO - mozrunner == 6.11 01:13:46 INFO - mozscreenshot == 0.1 01:13:46 INFO - mozsystemmonitor == 0.0 01:13:46 INFO - moztest == 0.7 01:13:46 INFO - mozversion == 1.4 01:13:46 INFO - psutil == 3.1.1 01:13:46 INFO - requests == 1.2.3 01:13:46 INFO - wsgiref == 0.1.2 01:13:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:13:46 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')]} 01:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:46 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')]} 01:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:46 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:46 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 01:13:46 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 01:13:46 INFO - Using env: {'DISPLAY': ':0', 01:13:46 INFO - 'HOME': '/home/cltbld', 01:13:46 INFO - 'LANG': 'en_US.UTF-8', 01:13:46 INFO - 'LANGUAGE': 'en_US:en', 01:13:46 INFO - 'LOGNAME': 'cltbld', 01:13:46 INFO - 'MAIL': '/var/mail/cltbld', 01:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:46 INFO - 'MOZ_NO_REMOTE': '1', 01:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:46 INFO - 'NO_EM_RESTART': '1', 01:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:46 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:46 INFO - 'SHELL': '/bin/bash', 01:13:46 INFO - 'SHLVL': '1', 01:13:46 INFO - 'TERM': 'linux', 01:13:46 INFO - 'TMOUT': '86400', 01:13:46 INFO - 'USER': 'cltbld', 01:13:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:46 INFO - '_': '/tools/buildbot/bin/python'} 01:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 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)) 01:13:46 INFO - Cleaning up... 01:13:46 INFO - Return code: 0 01:13:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:13:46 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')]} 01:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:46 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')]} 01:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:46 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:46 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 01:13:46 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 01:13:46 INFO - Using env: {'DISPLAY': ':0', 01:13:46 INFO - 'HOME': '/home/cltbld', 01:13:46 INFO - 'LANG': 'en_US.UTF-8', 01:13:46 INFO - 'LANGUAGE': 'en_US:en', 01:13:46 INFO - 'LOGNAME': 'cltbld', 01:13:46 INFO - 'MAIL': '/var/mail/cltbld', 01:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:46 INFO - 'MOZ_NO_REMOTE': '1', 01:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:46 INFO - 'NO_EM_RESTART': '1', 01:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:46 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:46 INFO - 'SHELL': '/bin/bash', 01:13:46 INFO - 'SHLVL': '1', 01:13:46 INFO - 'TERM': 'linux', 01:13:46 INFO - 'TMOUT': '86400', 01:13:46 INFO - 'USER': 'cltbld', 01:13:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:46 INFO - '_': '/tools/buildbot/bin/python'} 01:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:46 INFO - Downloading/unpacking jsonschema 01:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:13:48 INFO - Downloading/unpacking functools32 (from jsonschema) 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 INFO - Downloading functools32-3.2.3-2.tar.gz 01:13:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:13:48 INFO - warning: no files found matching '*.txt' 01:13:48 INFO - no previously-included directories found matching 'build' 01:13:48 INFO - no previously-included directories found matching 'dist' 01:13:48 INFO - no previously-included directories found matching '.git*' 01:13:48 INFO - Installing collected packages: jsonschema, functools32 01:13:48 INFO - Running setup.py install for functools32 01:13:48 INFO - warning: no files found matching '*.txt' 01:13:48 INFO - no previously-included directories found matching 'build' 01:13:48 INFO - no previously-included directories found matching 'dist' 01:13:48 INFO - no previously-included directories found matching '.git*' 01:13:48 INFO - Successfully installed jsonschema functools32 01:13:48 INFO - Cleaning up... 01:13:48 INFO - Return code: 0 01:13:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:48 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 0x7f2e5f1bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b18670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', '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 01:13:48 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 01:13:48 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 01:13:48 INFO - Using env: {'DISPLAY': ':0', 01:13:48 INFO - 'HOME': '/home/cltbld', 01:13:48 INFO - 'LANG': 'en_US.UTF-8', 01:13:48 INFO - 'LANGUAGE': 'en_US:en', 01:13:48 INFO - 'LOGNAME': 'cltbld', 01:13:48 INFO - 'MAIL': '/var/mail/cltbld', 01:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:48 INFO - 'MOZ_NO_REMOTE': '1', 01:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:48 INFO - 'NO_EM_RESTART': '1', 01:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:13:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:13:48 INFO - 'SHELL': '/bin/bash', 01:13:48 INFO - 'SHLVL': '1', 01:13:48 INFO - 'TERM': 'linux', 01:13:48 INFO - 'TMOUT': '86400', 01:13:48 INFO - 'USER': 'cltbld', 01:13:48 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:48 INFO - '_': '/tools/buildbot/bin/python'} 01:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:48 INFO - Downloading/unpacking flake8 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 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 01:13:48 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 01:13:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:13:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:13:50 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 01:13:50 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 01:13:50 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 01:13:50 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 01:13:50 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 01:13:50 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 01:13:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:13:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:13:51 INFO - no previously-included directories found matching 'docs/_build' 01:13:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:13:51 INFO - Running setup.py install for pep8 01:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:13:51 INFO - no previously-included directories found matching 'docs/_build' 01:13:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:13:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:13:51 INFO - Cleaning up... 01:13:51 INFO - Return code: 0 01:13:51 INFO - Running post-action listener: _resource_record_post_action 01:13:51 INFO - Running post-action listener: _start_resource_monitoring 01:13:51 INFO - Starting resource monitoring. 01:13:51 INFO - ##### 01:13:51 INFO - ##### Running install step. 01:13:51 INFO - ##### 01:13:51 INFO - Running pre-action listener: _resource_record_pre_action 01:13:51 INFO - Running main action method: install 01:13:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:13:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:13:52 INFO - Reading from file tmpfile_stdout 01:13:52 INFO - Detecting whether we're running mozinstall >=1.0... 01:13:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:13:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:13:52 INFO - Reading from file tmpfile_stdout 01:13:52 INFO - Output received: 01:13:52 INFO - Usage: mozinstall [options] installer 01:13:52 INFO - Options: 01:13:52 INFO - -h, --help show this help message and exit 01:13:52 INFO - -d DEST, --destination=DEST 01:13:52 INFO - Directory to install application into. [default: 01:13:52 INFO - "/builds/slave/test-pgo"] 01:13:52 INFO - --app=APP Application being installed. [default: firefox] 01:13:52 INFO - mkdir: /builds/slave/test-pgo/build/application 01:13:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:13:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:14:08 INFO - Reading from file tmpfile_stdout 01:14:08 INFO - Output received: 01:14:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:14:08 INFO - Running post-action listener: _resource_record_post_action 01:14:08 INFO - ##### 01:14:08 INFO - ##### Running run-tests step. 01:14:08 INFO - ##### 01:14:08 INFO - Running pre-action listener: _resource_record_pre_action 01:14:08 INFO - Running main action method: run_tests 01:14:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:14:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:14:08 INFO - Python 2.7.3 01:14:08 INFO - Return code: 0 01:14:08 INFO - grabbing minidump binary from tooltool 01:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:08 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 0x2ba78c0>, '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 0x2ba87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba8c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:14:08 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 01:14:08 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 01:14:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:14:08 INFO - Return code: 0 01:14:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:14:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:14:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:14:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:14:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:14:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:14:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:14:09 INFO - Return code: 0 01:14:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 01:14:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 01:14:09 INFO - Using env: {'DISPLAY': ':0', 01:14:09 INFO - 'HOME': '/home/cltbld', 01:14:09 INFO - 'LANG': 'en_US.UTF-8', 01:14:09 INFO - 'LANGUAGE': 'en_US:en', 01:14:09 INFO - 'LOGNAME': 'cltbld', 01:14:09 INFO - 'MAIL': '/var/mail/cltbld', 01:14:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:14:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:09 INFO - 'MOZ_NO_REMOTE': '1', 01:14:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:09 INFO - 'NO_EM_RESTART': '1', 01:14:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:14:09 INFO - 'PWD': '/builds/slave/test-pgo', 01:14:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:14:09 INFO - 'SHELL': '/bin/bash', 01:14:09 INFO - 'SHLVL': '1', 01:14:09 INFO - 'TERM': 'linux', 01:14:09 INFO - 'TMOUT': '86400', 01:14:09 INFO - 'USER': 'cltbld', 01:14:09 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218', 01:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:09 INFO - '_': '/tools/buildbot/bin/python'} 01:14:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:14:09 INFO - mozversion application_buildid: 20160224223120 01:14:09 INFO - mozversion application_changeset: 1f797f47e312c4ab9883bd48c9e3501619ff9e95 01:14:09 INFO - mozversion application_display_name: Nightly 01:14:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:14:09 INFO - mozversion application_name: Firefox 01:14:09 INFO - mozversion application_remotingname: firefox 01:14:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:14:09 INFO - mozversion application_vendor: Mozilla 01:14:09 INFO - mozversion application_version: 47.0a1 01:14:09 INFO - mozversion platform_buildid: 20160224223120 01:14:09 INFO - mozversion platform_changeset: 1f797f47e312c4ab9883bd48c9e3501619ff9e95 01:14:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:14:09 INFO - mozversion platform_version: 47.0a1 01:14:09 INFO - using testdate: 1456391649 01:14:09 INFO - actual date: 1456391649 01:14:09 INFO - starting webserver on 'localhost:51281' 01:14:09 INFO - SUITE-START | Running 2 tests 01:14:09 INFO - TEST-START | dromaeo_css 01:14:09 INFO - operating with platform_type : linux_ 01:14:09 INFO - Initialising browser for dromaeo_css test... 01:14:09 INFO - TEST-INFO | started process 4002 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi7hplX/profile http://localhost:51281/getInfo.html) 01:14:14 INFO - PROCESS | 4002 | __metrics Screen width/height:1600/1200 01:14:14 INFO - PROCESS | 4002 | colorDepth:24 01:14:14 INFO - PROCESS | 4002 | Browser inner width/height: 1024/697 01:14:14 INFO - PROCESS | 4002 | __metrics 01:14:15 INFO - PROCESS | 4002 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:14:16 INFO - TEST-INFO | 4002: exit 0 01:14:16 INFO - Browser initialized. 01:14:16 INFO - Running cycle 1/1 for dromaeo_css test... 01:14:16 INFO - TEST-INFO | started process 4096 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi7hplX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:28 INFO - PROCESS | 4096 | RSS: Main: 147111936 01:14:28 INFO - PROCESS | 4096 | 01:15:19 INFO - PROCESS | 4096 | 1456391719420 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] 01:17:27 INFO - PROCESS | 4096 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51281/tests/dromaeo/cssquery-ext.html) 01:17:28 INFO - PROCESS | 4096 | RSS: Main: 258703360 01:17:28 INFO - PROCESS | 4096 | 01:20:30 INFO - PROCESS | 4096 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-ext.html (next: http://localhost:51281/tests/dromaeo/cssquery-jquery.html) 01:20:31 INFO - PROCESS | 4096 | RSS: Main: 239394816 01:20:31 INFO - PROCESS | 4096 | 01:23:33 INFO - PROCESS | 4096 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51281/tests/dromaeo/cssquery-mootools.html) 01:23:33 INFO - PROCESS | 4096 | RSS: Main: 239144960 01:23:33 INFO - PROCESS | 4096 | 01:26:35 INFO - PROCESS | 4096 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51281/tests/dromaeo/cssquery-prototype.html) 01:26:36 INFO - PROCESS | 4096 | RSS: Main: 218542080 01:26:36 INFO - PROCESS | 4096 | 01:29:38 INFO - PROCESS | 4096 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51281/tests/dromaeo/cssquery-yui.html) 01:29:39 INFO - PROCESS | 4096 | RSS: Main: 219262976 01:29:39 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | Cycle 1(1): loaded http://localhost:51281/tests/dromaeo/cssquery-yui.html (next: http://localhost:51281/tests/dromaeo/cssquery-dojo.html) 01:32:42 INFO - PROCESS | 4096 | RSS: Main: 317829120 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | __start_tp_report 01:32:42 INFO - PROCESS | 4096 | _x_x_mozilla_page_load 01:32:42 INFO - PROCESS | 4096 | _x_x_mozilla_page_load_details 01:32:42 INFO - PROCESS | 4096 | |i|pagename|runs| 01:32:42 INFO - PROCESS | 4096 | |0;dojo.html;3155.384699983503;3178.126015345781;3213.3412650406667;3226.6450690424062;3249.3826173027132;5077.64456488045;5102.3111879896205;5132.43543210247;5150.356205474316;5173.741312934352;5160.483951604838;5185.144451165553;5193.766280517376;5208.531232189102;5278.313819203508;4659.254519276917;4728.361671174391;4778.952210477903;4797.784099715521;4831.903361932759;4639.884002899921;4701.059788042405;4758.857234282977;4766.523347665223;4887.315775791392;4751.786169622375;4766.070616229837;4766.499517550642;4782.689125206851;4811.615070794345;4759.50025247351;4784.378030856001;4787.16224660683;4794.49657785931;4815.542523460265;4658.091672123937;4682.8126874924965;4780.306855505967;4781.306710526954;4810.11012962603;5086.669366491166;5096.362954630671;5100.413452452941;5119.2321151827155;5124.385073791132;5572.080606699889;5586.190002449663;5590.888182236333;5593.077142271521;5631.60578759487;5528.308961379827;5608.158776183564;5613.438656134354;5676.659400435987;5679.034564124109;5273.235380869753;5298.36419629643;5299;5324.0150572144275;5326.041312563737;5754.539636829044;5770.278715160605;5777.768889244468;5788.363280039192;5790.189373487715;5388.084025715638;5481.013417584793;5548.278723765885;5575.414581468968;5599.664020158803;5575.526080283222;5578.804741834017;5580.944190558123;5582;5586.385497595261;5380.058489764276;5553.694546799884;5553.8333849984565;5557.194206840067;5604.859878502988;5483.506484416422;5536;5536.584756143306;5559.444055594408;5588.972055139699;4360.367746676714;4372.366006929041;4378.2119218540965;4386.824527018884;4420.138073075784;3823.4647149399107;3860.208657225262;3919.1573811630637;3924.3132451820816;3944.2111577684577;5253.55344795689;5266.815661451831;5273.472652734696;5274.525292723673;5320.76056577455;5620.662760234399;5642.125470552071;5649.915251271234;5651.773929042874;5652.886942261214;5093.8726531837;5195.584353251731;5265.104932161542;5268.868278292996;5296.443873393316;4722.456917454537;4749.738764367993;4751.263554149113;4763.904721905612;4789.736564488987;5720.141978703145;5741.1388291756575;5743.655380677173;5749.798757043483;5752.626079304831;5460.6177567569885;5493.642913210789;5543.944560554342;5596.0206963780365;5620.044592419216;5732.340780810094;5734.168545560787;5734.741936612946;5741;5743.684097374685;5415.675059496442;5417.945820541744;5422.5119739223655;5426.782928682808;5468.507834294933;5444.891102177855;5556.472135147154;5617.943820561742;5625.46558076982;5649.85875353103;5490.5882058844945;5492.368377636623;5513.972430137824;5517.668939863621;5521.447855214607;5345.786168553214;5496.450354964471;5516.448355164452;5520.447955204448;5554.1946417770005;5388.865278368072;5421.403645598902;5421.5391691706645;5428.864278393072;5475.233467314659;5445.83662490126;5447.400785913625;5471.644343117685;5473.534749546333;5474.808381706621;5248.475152484721;5347.705876176848;5356;5363.141897296414;5363.463653634605 01:32:42 INFO - PROCESS | 4096 | |1;ext.html;515.1962937817005;529.6292595183371;534.9251104845322;539.8380485854243;551.4320250142354;28521.572176417343;37293.81353093234;37479.250414991686;37493;37624.43563346549;40378.19243615133;40819.591804082025;40860.79569602148;40869.795651021705;40954;8425.1153628869;8649.827003459926;8661.610227539775;8662.696805611804;8669.436486628381;8340.499570025819;8453.239208471236;8464.957675211615;8470.534120623362;8636.309095272394;8654.134586541359;8715.128487151265;8718.389712720113;8720.781980450476;8723.476591404504;8600.22597966183;8636.136386361377;8655.913440865574;8664.133586641348;8671.609777560025;8611.741647750578;8695.478271303742;8717.825643487158;8733.170348816851;8739.300855931573;40117.398239026435;40567.59432405697;40597.39103913444;40608.79695601533;40668;3310.8841190558214;3543.982280088583;3609.873654422083;3707.5921648618632;3911.7261791674596;30424.391512169856;30539.847300763577;30624.77500899961;30779.538306925413;30822.53766193509;3847.826847791856;3914.6868250540174;3919.431682406064;3935.2129574085297;3936.980315098435;261592;262885.9999999981;263136;263271;263925;59910.10134847981;60014.399856000884;60295;60309.39690603125;60376.39623603708;62383.37616623867;62586;64792;65709;65729.34270657328;16441.588960276087;16637.584060398585;16674.58313542171;16688.916555417145;16719.080450575093;12575.496980120693;12621.747565048647;12642.494300228072;12665.113442058968;12670;19968.50078748043;20203.292884748964;20231.393058208276;20245.392638220877;20277.391678249674;7980.162082981319;8150.592470376458;8312.6674933002;8352.12302708219;8357.247847693616;864.8400045991386;886.8581027035643;919.632147141149;934.2525979216599;1027.2295778166376;24772.132975345776;25357.239282821545;25480.23559293224;25515.234542963368;27006;955.1833182628891;977.9266555008261;1020.1736593359402;1022.4580972084658;1042.2131290875493;12689.428975696115;13032;13086.411111500005;13095.083344166007;13110.213387196798;358000;358223;362131;362201;363345;54392.45607543953;54598.727006364716;55134;55227.72386138044;55342.44657553373;1190.8809119088196;1282.33959510852;1286.7169222770976;1365.7405093032291;1398.223985687953;24222.515549688556;24275.271741847773;24428;24436.755632444158;24468;38432;38689.22621547497;38702.22595548017;39376.803115984236;39583.20833583255;166997;168127.1593642073;174731;176253;176478.11760941113;27591.31021724473;31757.8412107938;32208.677913220567;32407.027789166365;32611.673883260864;38033;38070.2385952285;38421.61578384292;38523.42214866835;39106.804465978625;32415;32526.34947301088;32726.836365818017;35032.474512882836;35520.82239588785;32751.672483274862;34740.305193895474;35150.824245878604;35168.29663406769;35645.28709425745;29936.70063299339;30334.84832575823;30749.53875691911;30788;30945;29012.843890433443;31101.844490777403;32182.19544511406;32202.83898580492;32278.35443291074;21208.575828483652;21382.893085534473;21437.142514299252;21487.785122149206;21567.676484852425 01:32:42 INFO - PROCESS | 4096 | |2;jquery.html;355.9537260156181;359.72481051995226;365.8993776711404;366.89543480108176;371.0131051403268;16795.916020419896;17254.82745172548;17480.38818641348;17819.46541603754;17822.46532604024;10987.61543345983;11356.716082097952;11376;11378.772424551504;16356.1004144772;4898.828541001057;5008.774605142759;5009.649324547283;5041.899162016776;5045.672031317952;4928.236123400879;5030.522100400456;5041.596672266228;5066.569341605949;5067.797288108472;5029;5034.773435195425;5038.521340472649;5039.899202015958;5084.288199652052;5065.898682026357;5210.843674689746;5436.537894278991;5439.075357189287;5445.237666726662;5206.427292997767;5211.5049070338255;5215.452377500345;5221.686698798047;5235.869103272411;14157.929210353985;20144.89927550353;20727.27454539099;20747.170113195603;20762.169513219455;2077.8233850122756;2118.343313572782;2482.91309804156;2597.779188768957;2747.958780618292;9352.859707104399;9416.670416535457;9671.274654400877;9748.220142388593;12284.692882677915;1773.813749556291;1798.7481752554652;1802.9098545072693;1810;1822.6263615958696;62197.68901155511;65991.34008659948;66910.33089669139;67321.66339168273;67887.66056169737;10179.592816287266;10187.08316251541;10452.275374563264;10452.372857628567;10530.473476326153;13850.376733047036;13915.512957046454;13916.791248131287;13923.930380348034;13937.024408291321;7418.109826820816;7657.119431265364;7659.885101723478;7749.7675069748;7759.068911730628;7354.448416368794;7430.145533263744;7496.362809161174;7515.398768098539;7538.057742782153;4456.866294011184;4459.598636122764;4498.887527811766;4604.976975115103;4627.976860115745;1730.3338214787145;1735.4706814421722;1752.325354738435;1774.8313910178513;1775.6182420779594;848.2874385516196;859.9140085991476;900.2572877376191;906.7279816055157;937.3906960475609;14869.702605947821;15149.365883175675;15402.614934626725;15569.143697096768;15683;867.6312567158932;878.9428687135315;886.822635472908;888.1583832943164;921.6958403726754;8554.91445085541;8682.86975695365;8723.345749068845;8783.989841168348;8847.159519845605;391793;396799;406038;408070;409105;56629;66305.6684716583;67887.3211267881;73913.26086739171;77637.223627763;968.2786324188525;971.223021582731;990.3117333453181;994.3089552760762;1020.2144348851491;13854.792178117537;14195.077319974169;14276.357563909442;14421.855781442051;14522.85477145215;31748.523772143897;33870.153246169044;34560.308793824486;34723.95703222583;34904;45410.77294613506;46039.07921841477;47046.76476617595;47789.283160753315;47790.283145752146;7952.244536768998;8003.799905002422;8058.637361318638;8116.472429292077;8194.426390152632;9662.323637345318;12303.200291980993;12525.37373131358;12788.744225115632;12800.16798908068;9867.950660246654;9892;9984.450855203033;10447.268691191544;10819.188560858125;10637.255392122477;10658.786824263316;10663.8933610666;10704.357738535713;10802.297850639683;8860.538011228075;8889.688860889837;10308;10606.098481629147;10850.837237441287;8012.83974320522;8026.478278912085;8084.39367047462;8174.918250817415;8241.83516329682;9961.900380996098;10407.427591482541;10497.842532362174;10586.947065264625;10596.8940310599 01:32:42 INFO - PROCESS | 4096 | |3;mootools.html;1388.1393536007665;1499.160470136724;1501.7597184450487;1688.4850120713186;1830.368522859614;7530.774076777699;7698.384129269659;7737.690492380305;7738.767836964893;7746.573938433398;7586.279303466175;7772.417068719855;7789.376849852012;7794.532328060321;7798.999999999985;2021.312753663754;2058.5779915117364;2228.487447886987;2261.061659411346;2290.3701482092392;2259.2544460328054;2265.365697604665;2268.5009297954425;2270.2735124760084;2271.068861766676;2186.35502526755;2212.225720997654;2218.4453886528368;2265.8300627452923;2269.205777977703;2158.6006588781124;2223.3107736601623;2227.6658501224783;2231.9107235710553;2231.9218827341047;2151.774063723318;2167.3822960456196;2168.4036889855256;2170.522485053286;2171.880546569938;7940.761777146695;7987.720429784988;7994.440389172761;8009.919900801034;8015.519068855829;4667.369905062807;4758.690685105457;4790.712557246541;4795.520447955211;4796.136695394827;2938.808977416461;2946.5138252188362;3035.195673146618;3049.7560195184333;3050.7864449488325;927.9304052196045;933.9159475647224;938.3290946972879;964.8022155458115;976.3117002513211;10797.244192906499;10814.35113893169;10828.025477706966;10839.241253112285;10844;4197.853075142355;4240.915181696349;4309.978450107792;4324.394584758136;4325.891852703708;9086.136817002374;9093;9105.453672779655;9116;9126.315526335418;4756.6432517561325;4759.857204283877;4793.041391721669;4793.089313030513;4795.688280261772;3978.741381810173;3981.900452488711;4014.658754005884;4223.894402639959;4358.346248062816;3506.7369947253546;3601.6218297078954;3610.6028336882923;3625.9456108158397;3655.6892664123848;1163.790517706804;1166.2069792541154;1167.7080729817546;1185.04603793945;1185.7035741064733;1324.589377293023;1326.8407791065133;1327.6481732340937;1360.251861476184;1372.4167228927665;7251.492395532262;7496.850062998709;7536.623168841646;7606.695732170651;7636.847263054708;1144.553624086607;1145.0782120393164;1145.8166693329194;1150.1316506038056;1151.8445009923553;5693.28833895763;5774.624649397776;5829.154772557956;5835.94164058354;5838.007538718428;8905.510196939102;9281.535923203814;9381.812363752686;9416.811663766823;9563.330566860253;9263.25893928484;9360.90639093614;9416.43501389905;9450.810983780424;9452.291078169164;7295.197528271886;7406.629668516661;7421.257874212643;7438;7494.288042635941;7230.530015548972;7271.3455788979245;7274.381677557467;7275.054242948383;7294.63526823646;8238.752837414888;8326.167383261625;8407.327413807003;8514.807926890117;8573.957130214309;8352.41533092702;8468.66125354979;8497.74506764798;8529.530875801891;8630.697925572826;6383.202099737533;6458.128152699325;6613.107230523818;6708.6310252936555;6771.729130834909;7540.924590754023;7592.126905405949;7621.428392870446;7622.9237707622215;7632.045994250719;6651.567648103051;6911.723531058701;6945.166580010431;6955.686994085379;7071.25751796054;6780.660966951534;6807.931920680928;6864.279250678607;6892.276310987475;6951.652417379212;6846.452283817183;6907.930920690729;6914.135733033371;6962.373386395248;7089.680964356513;6576.638284894377;6579.638119903259;6607.075009498578;6614.173228346457;6623.3376662333385;6461.386168314003;6565.179352580927;6612.933870661232;6617.272100069084;6619.040239165391 01:32:42 INFO - PROCESS | 4096 | |4;prototype.html;339.91332210286373;345.71823963469774;350.07754566716704;354.9591796943352;355.98220088995544;5870.236869207008;5873.882522349556;5916.319623243328;5940.524758019348;5983.072623743326;5834.241548598677;5836.970815145929;5837.678927658977;5844.795432159875;5848.093545500444;4381.123775244956;4409.889752756175;4483.663725220606;4488.775561221943;4498;4471.843485478009;4486.125205584913;4486.1700585391645;4490.101979604092;4492.2812350024005;4364.127174565084;4477.238869392211;4501.3022981437925;4509.210888094571;4516.1193567254395;4440.134173836087;4440.600345968878;4445.399871017404;4503.301988191835;4522.570355816192;3972.2651309507546;3980.7611543307203;3982.9402558961638;3994.2610617035944;3995.4406383106098;5524.419935906712;5528.032594296023;5537.36320323164;5598.832035038955;5611.494965453129;5275.235090911835;5288.8413347599635;5292.52367286946;5301.867453313659;5313.787448502056;6217.906731398987;6225.87548249037;6233.376662333776;6233.594816336924;6236.65911828959;4191.580841915815;4269.679774016961;4284.250256205183;4284.635805956466;4470.441194850644;6418.486521078303;6471.5146364022885;6482.805515834532;6502.349765023459;6504.349565043505;4397.098594788061;4412.624926881187;4429.645628349725;4438.955610443919;4452.710573812692;4496.437945256843;4501.41481607389;4502.977485112619;4503.369528266046;4506.909861802811;5160.896782064413;5166.664166829144;5179.663321884141;5189.532942035235;5191.532762051434;6050.6369617823075;6244.438000579969;6246.937530624727;6266.874662506724;6313.053042043638;1554.432632089302;1581.683663267328;1591.283922234999;1592.896461729984;1593.8246792852776;987.5457289646843;990.3958585262984;1004.7036124343336;1054.1250761867632;1078.0513148429332;5947.04847224442;5961.5230781537375;5961.986462301419;5967.045272756338;5971.462568368867;6417.903731444032;6424.229092508929;6430.871382572416;6435.292117867031;6438.066480360321;5926.140709597084;5941.494972927349;5952.0476723724;5953;5959.046552551571;3425.3320602482277;3432.1076520104452;3441.913952151216;3452;3456.118689734152;6600.504962127764;6688.933110668831;6701.966490167518;6823.863522729517;6864.931350686529;6672.366125218096;6711.932880671131;6717.227518835299;6719.764808231688;6721.1598550181225;6822.556533825385;6827.658617069127;6845.041694162821;6849.1438570178725;6849.349311815369;6498.675066246763;6501.479881609365;6513.218413790375;6516.152900122954;6527;6253.968730156502;6452.580582262138;6459.257185423737;6464.612123272431;6492.675366231764;6712.597244165366;6755.93244067553;6769.796906092825;6778.186617605918;6844.178698556205;4466.620337271238;4502.954970450384;4506.639468842419;4507.5943165115295;4509.90980180388;6534.771283005072;6541.672916354259;6542.411182993554;6543.967280163569;6553.279139294769;6368.299487056327;6376.458001069961;6411.4870810336;6413;6417.7753778617525;6171.1668924694595;6327.209098862642;6345.0482427636225;6363.204599425072;6365.840853978688;6196.0705894116245;6218.378162183745;6238.532110091852;6239.0953311770445;6243.157173781481;6376.298607153117;6383.6808159592765;6384.9042264367;6385.169927909528;6394.2646595640235;5945.3757355477055;6072.362401947732;6212.627242365473;6218.253809542884;6225.8132256032395 01:32:42 INFO - PROCESS | 4096 | |5;yui.html;725.7895210388984;735.4998600951352;735.8896165575167;785.7996210966203;820.6430202861756;13087.672808179801;13236.801447978289;13249.470021199164;13250.403731832066;13290.933545332271;13119.47522099115;13131.606051818437;13137.868621313808;13141.408636611375;13154.342282885842;686.7733647896182;805.114374188391;830.4767996162409;841.3311417423163;844.624142256696;817.3012074676155;823.7528741377592;827.2472050434106;828.1387357148558;828.9709860154895;868.079835374505;879.6525372477868;879.6965047058786;880.7886107334226;881.1496905486205;700.7127077898062;861.3841103610916;878.6046279174333;878.8242351529688;879.0725784297564;640.9487241020707;645.3062957320899;650.5738741124571;651.8500744828716;652.5138771615129;12694.428750706147;12755.936220318932;12802.679933001657;12825.807612885814;12839.679008024781;12848.935755321258;13045.804312935219;13141.934290328583;13145.145565538305;13360.599182024554;10654.62708805188;10766.892331076746;10785.46072696362;10893.291936024134;10913.727156821064;3593.4969104325414;3627.9274414511824;3650.5984341722387;3673.3938900081453;3783.697304215656;47964;48167.75916120432;48936.26595601069;48981;49673.751631241976;9225.53872306382;9369.437833729999;9377.906220937839;9490.383125096847;9841.45871977048;16971.575710607332;17245.482635520955;18526.795758275668;18701;18706.06469676511;7567.962160189274;7659;7670.693172273158;7687.692492300357;7708.03649543807;4480.126375356775;4488.236999710057;4519.570640789119;4619.076184763061;4654.534546545387;3148.5592017117624;3157.984210078981;3171.952420713691;3177.189816596753;3179.42770301348;580.274656679151;587.8471597384711;588.4674369695432;596.9970150149221;621.0094898636668;561.8370672504927;605.4944121658465;643.1960049937578;672.2605134352272;687.8314812870879;8303.377246706521;8547.914520854712;8634.827303453896;8786.516741579147;8891.155340242796;658.1079396734389;660.920689517261;685.1948959972013;695.600029982762;706.9681864316118;3876.9418458723144;4052.797360131982;4108.548059713429;4158.563350848178;4221.64116050133;52765;53126.734366327924;53194.73402632962;57319.42680573224;58712.41287587155;44062.33906491405;45286.77356613196;45500.77249613731;45727.542724572326;45989.310160346955;41686.58313416827;41968.79015604902;42595;43679.56320436755;43762.12475750467;8536;8634.611442484978;8785.428947118417;8816.382853200214;8837.293016558531;35633.28733425369;35933;36734.63265367312;37277.25445491129;37667.623323767504;47893.28160077671;48052.03895922132;48269.75865120652;48855.75572122117;49922.75038624783;11515.374737449774;11964.64106076819;12011.879881201075;12061.577844775391;12694.746105078031;12320.445579949102;12359.3820308986;12846.935765321114;13055;13220.735585288432;11941.52233910634;12039.518419263482;12300.753984920431;12433;12715.745685086431;11758.176927614984;12014.879851201376;12116.21244619097;12442.688932776753;12752.298623575793;11798.11514136426;12052.337121458404;12207.816882746589;12541.435635396247;12586.937065314614;9486.667966621135;9622.615095396106;9859.654912078044;9999.400035997864;10088.546015429176;8704;9339.719808405758;9362.672306469241;9667.758306042406;9784.51077446139 01:32:42 INFO - PROCESS | 4096 | __end_tp_report 01:32:42 INFO - PROCESS | 4096 | __start_cc_report 01:32:42 INFO - PROCESS | 4096 | _x_x_mozilla_cycle_collect,865 01:32:42 INFO - PROCESS | 4096 | __end_cc_report 01:32:42 INFO - PROCESS | 4096 | __startTimestamp1456392762284__endTimestamp 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | ------- Summary: start ------- 01:32:42 INFO - PROCESS | 4096 | Number of tests: 6 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | [#0] dojo.html Cycles:165 Average:5192.55 Median:5388.08 stddev:556.10 (10.3%) stddev-sans-first:534.35 01:32:42 INFO - PROCESS | 4096 | Values: 3155.4 3178.1 3213.3 3226.6 3249.4 5077.6 5102.3 5132.4 5150.4 5173.7 5160.5 5185.1 5193.8 5208.5 5278.3 4659.3 4728.4 4779.0 4797.8 4831.9 4639.9 4701.1 4758.9 4766.5 4887.3 4751.8 4766.1 4766.5 4782.7 4811.6 4759.5 4784.4 4787.2 4794.5 4815.5 4658.1 4682.8 4780.3 4781.3 4810.1 5086.7 5096.4 5100.4 5119.2 5124.4 5572.1 5586.2 5590.9 5593.1 5631.6 5528.3 5608.2 5613.4 5676.7 5679.0 5273.2 5298.4 5299.0 5324.0 5326.0 5754.5 5770.3 5777.8 5788.4 5790.2 5388.1 5481.0 5548.3 5575.4 5599.7 5575.5 5578.8 5580.9 5582.0 5586.4 5380.1 5553.7 5553.8 5557.2 5604.9 5483.5 5536.0 5536.6 5559.4 5589.0 4360.4 4372.4 4378.2 4386.8 4420.1 3823.5 3860.2 3919.2 3924.3 3944.2 5253.6 5266.8 5273.5 5274.5 5320.8 5620.7 5642.1 5649.9 5651.8 5652.9 5093.9 5195.6 5265.1 5268.9 5296.4 4722.5 4749.7 4751.3 4763.9 4789.7 5720.1 5741.1 5743.7 5749.8 5752.6 5460.6 5493.6 5543.9 5596.0 5620.0 5732.3 5734.2 5734.7 5741.0 5743.7 5415.7 5417.9 5422.5 5426.8 5468.5 5444.9 5556.5 5617.9 5625.5 5649.9 5490.6 5492.4 5514.0 5517.7 5521.4 5345.8 5496.5 5516.4 5520.4 5554.2 5388.9 5421.4 5421.5 5428.9 5475.2 5445.8 5447.4 5471.6 5473.5 5474.8 5248.5 5347.7 5356.0 5363.1 5363.5 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | [#1] ext.html Cycles:180 Average:43297.31 Median:362166.00 stddev:72723.65 (20.1%) stddev-sans-first:72856.71 01:32:42 INFO - PROCESS | 4096 | Values: 515.2 529.6 534.9 539.8 551.4 28521.6 37293.8 37479.3 37493.0 37624.4 40378.2 40819.6 40860.8 40869.8 40954.0 8425.1 8649.8 8661.6 8662.7 8669.4 8340.5 8453.2 8465.0 8470.5 8636.3 8654.1 8715.1 8718.4 8720.8 8723.5 8600.2 8636.1 8655.9 8664.1 8671.6 8611.7 8695.5 8717.8 8733.2 8739.3 40117.4 40567.6 40597.4 40608.8 40668.0 3310.9 3544.0 3609.9 3707.6 3911.7 30424.4 30539.8 30624.8 30779.5 30822.5 3847.8 3914.7 3919.4 3935.2 3937.0 261592.0 262886.0 263136.0 263271.0 263925.0 59910.1 60014.4 60295.0 60309.4 60376.4 62383.4 62586.0 64792.0 65709.0 65729.3 16441.6 16637.6 16674.6 16688.9 16719.1 12575.5 12621.7 12642.5 12665.1 12670.0 19968.5 20203.3 20231.4 20245.4 20277.4 7980.2 8150.6 8312.7 8352.1 8357.2 864.8 886.9 919.6 934.3 1027.2 24772.1 25357.2 25480.2 25515.2 27006.0 955.2 977.9 1020.2 1022.5 1042.2 12689.4 13032.0 13086.4 13095.1 13110.2 358000.0 358223.0 362131.0 362201.0 363345.0 54392.5 54598.7 55134.0 55227.7 55342.4 1190.9 1282.3 1286.7 1365.7 1398.2 24222.5 24275.3 24428.0 24436.8 24468.0 38432.0 38689.2 38702.2 39376.8 39583.2 166997.0 168127.2 174731.0 176253.0 176478.1 27591.3 31757.8 32208.7 32407.0 32611.7 38033.0 38070.2 38421.6 38523.4 39106.8 32415.0 32526.3 32726.8 35032.5 35520.8 32751.7 34740.3 35150.8 35168.3 35645.3 29936.7 30334.8 30749.5 30788.0 30945.0 29012.8 31101.8 32182.2 32202.8 32278.4 21208.6 21382.9 21437.1 21487.8 21567.7 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | [#2] jquery.html Cycles:180 Average:23975.69 Median:4616.48 stddev:66105.54 (1431.9%) stddev-sans-first:66267.19 01:32:42 INFO - PROCESS | 4096 | Values: 356.0 359.7 365.9 366.9 371.0 16795.9 17254.8 17480.4 17819.5 17822.5 10987.6 11356.7 11376.0 11378.8 16356.1 4898.8 5008.8 5009.6 5041.9 5045.7 4928.2 5030.5 5041.6 5066.6 5067.8 5029.0 5034.8 5038.5 5039.9 5084.3 5065.9 5210.8 5436.5 5439.1 5445.2 5206.4 5211.5 5215.5 5221.7 5235.9 14157.9 20144.9 20727.3 20747.2 20762.2 2077.8 2118.3 2482.9 2597.8 2748.0 9352.9 9416.7 9671.3 9748.2 12284.7 1773.8 1798.7 1802.9 1810.0 1822.6 62197.7 65991.3 66910.3 67321.7 67887.7 10179.6 10187.1 10452.3 10452.4 10530.5 13850.4 13915.5 13916.8 13923.9 13937.0 7418.1 7657.1 7659.9 7749.8 7759.1 7354.4 7430.1 7496.4 7515.4 7538.1 4456.9 4459.6 4498.9 4605.0 4628.0 1730.3 1735.5 1752.3 1774.8 1775.6 848.3 859.9 900.3 906.7 937.4 14869.7 15149.4 15402.6 15569.1 15683.0 867.6 878.9 886.8 888.2 921.7 8554.9 8682.9 8723.3 8784.0 8847.2 391793.0 396799.0 406038.0 408070.0 409105.0 56629.0 66305.7 67887.3 73913.3 77637.2 968.3 971.2 990.3 994.3 1020.2 13854.8 14195.1 14276.4 14421.9 14522.9 31748.5 33870.2 34560.3 34724.0 34904.0 45410.8 46039.1 47046.8 47789.3 47790.3 7952.2 8003.8 8058.6 8116.5 8194.4 9662.3 12303.2 12525.4 12788.7 12800.2 9868.0 9892.0 9984.5 10447.3 10819.2 10637.3 10658.8 10663.9 10704.4 10802.3 8860.5 8889.7 10308.0 10606.1 10850.8 8012.8 8026.5 8084.4 8174.9 8241.8 9961.9 10407.4 10497.8 10586.9 10596.9 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | [#3] mootools.html Cycles:180 Average:5466.67 Median:6593.36 stddev:2840.94 (43.1%) stddev-sans-first:2832.37 01:32:42 INFO - PROCESS | 4096 | Values: 1388.1 1499.2 1501.8 1688.5 1830.4 7530.8 7698.4 7737.7 7738.8 7746.6 7586.3 7772.4 7789.4 7794.5 7799.0 2021.3 2058.6 2228.5 2261.1 2290.4 2259.3 2265.4 2268.5 2270.3 2271.1 2186.4 2212.2 2218.4 2265.8 2269.2 2158.6 2223.3 2227.7 2231.9 2231.9 2151.8 2167.4 2168.4 2170.5 2171.9 7940.8 7987.7 7994.4 8009.9 8015.5 4667.4 4758.7 4790.7 4795.5 4796.1 2938.8 2946.5 3035.2 3049.8 3050.8 927.9 933.9 938.3 964.8 976.3 10797.2 10814.4 10828.0 10839.2 10844.0 4197.9 4240.9 4310.0 4324.4 4325.9 9086.1 9093.0 9105.5 9116.0 9126.3 4756.6 4759.9 4793.0 4793.1 4795.7 3978.7 3981.9 4014.7 4223.9 4358.3 3506.7 3601.6 3610.6 3625.9 3655.7 1163.8 1166.2 1167.7 1185.0 1185.7 1324.6 1326.8 1327.6 1360.3 1372.4 7251.5 7496.9 7536.6 7606.7 7636.8 1144.6 1145.1 1145.8 1150.1 1151.8 5693.3 5774.6 5829.2 5835.9 5838.0 8905.5 9281.5 9381.8 9416.8 9563.3 9263.3 9360.9 9416.4 9450.8 9452.3 7295.2 7406.6 7421.3 7438.0 7494.3 7230.5 7271.3 7274.4 7275.1 7294.6 8238.8 8326.2 8407.3 8514.8 8574.0 8352.4 8468.7 8497.7 8529.5 8630.7 6383.2 6458.1 6613.1 6708.6 6771.7 7540.9 7592.1 7621.4 7622.9 7632.0 6651.6 6911.7 6945.2 6955.7 7071.3 6780.7 6807.9 6864.3 6892.3 6951.7 6846.5 6907.9 6914.1 6962.4 7089.7 6576.6 6579.6 6607.1 6614.2 6623.3 6461.4 6565.2 6612.9 6617.3 6619.0 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | [#4] prototype.html Cycles:180 Average:5251.12 Median:5949.55 stddev:1597.77 (26.9%) stddev-sans-first:1559.15 01:32:42 INFO - PROCESS | 4096 | Values: 339.9 345.7 350.1 355.0 356.0 5870.2 5873.9 5916.3 5940.5 5983.1 5834.2 5837.0 5837.7 5844.8 5848.1 4381.1 4409.9 4483.7 4488.8 4498.0 4471.8 4486.1 4486.2 4490.1 4492.3 4364.1 4477.2 4501.3 4509.2 4516.1 4440.1 4440.6 4445.4 4503.3 4522.6 3972.3 3980.8 3982.9 3994.3 3995.4 5524.4 5528.0 5537.4 5598.8 5611.5 5275.2 5288.8 5292.5 5301.9 5313.8 6217.9 6225.9 6233.4 6233.6 6236.7 4191.6 4269.7 4284.3 4284.6 4470.4 6418.5 6471.5 6482.8 6502.3 6504.3 4397.1 4412.6 4429.6 4439.0 4452.7 4496.4 4501.4 4503.0 4503.4 4506.9 5160.9 5166.7 5179.7 5189.5 5191.5 6050.6 6244.4 6246.9 6266.9 6313.1 1554.4 1581.7 1591.3 1592.9 1593.8 987.5 990.4 1004.7 1054.1 1078.1 5947.0 5961.5 5962.0 5967.0 5971.5 6417.9 6424.2 6430.9 6435.3 6438.1 5926.1 5941.5 5952.0 5953.0 5959.0 3425.3 3432.1 3441.9 3452.0 3456.1 6600.5 6688.9 6702.0 6823.9 6864.9 6672.4 6711.9 6717.2 6719.8 6721.2 6822.6 6827.7 6845.0 6849.1 6849.3 6498.7 6501.5 6513.2 6516.2 6527.0 6254.0 6452.6 6459.3 6464.6 6492.7 6712.6 6755.9 6769.8 6778.2 6844.2 4466.6 4503.0 4506.6 4507.6 4509.9 6534.8 6541.7 6542.4 6544.0 6553.3 6368.3 6376.5 6411.5 6413.0 6417.8 6171.2 6327.2 6345.0 6363.2 6365.8 6196.1 6218.4 6238.5 6239.1 6243.2 6376.3 6383.7 6384.9 6385.2 6394.3 5945.4 6072.4 6212.6 6218.3 6225.8 01:32:42 INFO - PROCESS | 4096 | 01:32:42 INFO - PROCESS | 4096 | [#5] yui.html Cycles:180 Average:13763.71 Median:26273.91 stddev:15508.38 (59.0%) stddev-sans-first:15520.98 01:32:42 INFO - PROCESS | 4096 | Values: 725.8 735.5 735.9 785.8 820.6 13087.7 13236.8 13249.5 13250.4 13290.9 13119.5 13131.6 13137.9 13141.4 13154.3 686.8 805.1 830.5 841.3 844.6 817.3 823.8 827.2 828.1 829.0 868.1 879.7 879.7 880.8 881.1 700.7 861.4 878.6 878.8 879.1 640.9 645.3 650.6 651.9 652.5 12694.4 12755.9 12802.7 12825.8 12839.7 12848.9 13045.8 13141.9 13145.1 13360.6 10654.6 10766.9 10785.5 10893.3 10913.7 3593.5 3627.9 3650.6 3673.4 3783.7 47964.0 48167.8 48936.3 48981.0 49673.8 9225.5 9369.4 9377.9 9490.4 9841.5 16971.6 17245.5 18526.8 18701.0 18706.1 7568.0 7659.0 7670.7 7687.7 7708.0 4480.1 4488.2 4519.6 4619.1 4654.5 3148.6 3158.0 3172.0 3177.2 3179.4 580.3 587.8 588.5 597.0 621.0 561.8 605.5 643.2 672.3 687.8 8303.4 8547.9 8634.8 8786.5 8891.2 658.1 660.9 685.2 695.6 707.0 3876.9 4052.8 4108.5 4158.6 4221.6 52765.0 53126.7 53194.7 57319.4 58712.4 44062.3 45286.8 45500.8 45727.5 45989.3 41686.6 41968.8 42595.0 43679.6 43762.1 8536.0 8634.6 8785.4 8816.4 8837.3 35633.3 35933.0 36734.6 37277.3 37667.6 47893.3 48052.0 48269.8 48855.8 49922.8 11515.4 11964.6 12011.9 12061.6 12694.7 12320.4 12359.4 12846.9 13055.0 13220.7 11941.5 12039.5 12300.8 12433.0 12715.7 11758.2 12014.9 12116.2 12442.7 12752.3 11798.1 12052.3 12207.8 12541.4 12586.9 9486.7 9622.6 9859.7 9999.4 10088.5 8704.0 9339.7 9362.7 9667.8 9784.5 01:32:42 INFO - PROCESS | 4096 | -------- Summary: end -------- 01:32:42 INFO - PROCESS | 4096 | 01:32:43 INFO - TEST-INFO | 4096: exit 0 01:32:43 INFO - TEST-OK | dromaeo_css | took 1113362ms 01:32:43 INFO - TEST-START | kraken 01:32:43 INFO - operating with platform_type : linux_ 01:32:43 INFO - Initialising browser for kraken test... 01:32:43 INFO - TEST-INFO | started process 4276 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxpI0ic/profile http://localhost:51281/getInfo.html) 01:32:47 INFO - PROCESS | 4276 | __metrics Screen width/height:1600/1200 01:32:47 INFO - PROCESS | 4276 | colorDepth:24 01:32:47 INFO - PROCESS | 4276 | Browser inner width/height: 1024/697 01:32:47 INFO - PROCESS | 4276 | __metrics 01:32:48 INFO - PROCESS | 4276 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:32:49 INFO - TEST-INFO | 4276: exit 0 01:32:49 INFO - Browser initialized. 01:32:49 INFO - Running cycle 1/1 for kraken test... 01:32:49 INFO - TEST-INFO | started process 4361 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxpI0ic/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:01 INFO - PROCESS | 4361 | RSS: Main: 147357696 01:33:01 INFO - PROCESS | 4361 | 01:33:03 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-beat-detection) 01:33:04 INFO - PROCESS | 4361 | RSS: Main: 191700992 01:33:04 INFO - PROCESS | 4361 | 01:33:06 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-dft) 01:33:07 INFO - PROCESS | 4361 | RSS: Main: 181002240 01:33:07 INFO - PROCESS | 4361 | 01:33:10 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-fft) 01:33:10 INFO - PROCESS | 4361 | RSS: Main: 167202816 01:33:10 INFO - PROCESS | 4361 | 01:33:12 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51281/tests/kraken/driver.html?testName=audio-oscillator) 01:33:13 INFO - PROCESS | 4361 | RSS: Main: 166723584 01:33:13 INFO - PROCESS | 4361 | 01:33:15 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:33:16 INFO - PROCESS | 4361 | RSS: Main: 167653376 01:33:16 INFO - PROCESS | 4361 | 01:33:19 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51281/tests/kraken/driver.html?testName=imaging-darkroom) 01:33:19 INFO - PROCESS | 4361 | RSS: Main: 167809024 01:33:19 INFO - PROCESS | 4361 | 01:33:23 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51281/tests/kraken/driver.html?testName=imaging-desaturate) 01:33:23 INFO - PROCESS | 4361 | RSS: Main: 169668608 01:33:23 INFO - PROCESS | 4361 | 01:33:26 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51281/tests/kraken/driver.html?testName=json-parse-financial) 01:33:27 INFO - PROCESS | 4361 | RSS: Main: 170418176 01:33:27 INFO - PROCESS | 4361 | 01:33:28 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:33:29 INFO - PROCESS | 4361 | RSS: Main: 182726656 01:33:29 INFO - PROCESS | 4361 | 01:33:31 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:33:31 INFO - PROCESS | 4361 | RSS: Main: 176955392 01:33:31 INFO - PROCESS | 4361 | 01:33:33 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:33:34 INFO - PROCESS | 4361 | RSS: Main: 190791680 01:33:34 INFO - PROCESS | 4361 | 01:33:36 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:33:37 INFO - PROCESS | 4361 | RSS: Main: 196018176 01:33:37 INFO - PROCESS | 4361 | 01:33:40 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:33:40 INFO - PROCESS | 4361 | RSS: Main: 195174400 01:33:40 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | Cycle 1(1): loaded http://localhost:51281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51281/tests/kraken/driver.html?testName=ai-astar) 01:33:42 INFO - PROCESS | 4361 | RSS: Main: 256049152 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | __start_tp_report 01:33:42 INFO - PROCESS | 4361 | _x_x_mozilla_page_load 01:33:42 INFO - PROCESS | 4361 | _x_x_mozilla_page_load_details 01:33:42 INFO - PROCESS | 4361 | |i|pagename|runs| 01:33:42 INFO - PROCESS | 4361 | |0;ai-astar;109;111;104;109;110;112;98;109;109;111 01:33:42 INFO - PROCESS | 4361 | |1;audio-beat-detection;151;129;154;160;131;151;153;127;179;129 01:33:42 INFO - PROCESS | 4361 | |2;audio-dft;162;162;161;161;162;160;161;165;163;161 01:33:42 INFO - PROCESS | 4361 | |3;audio-fft;74;73;102;99;73;73;74;113;96;73 01:33:42 INFO - PROCESS | 4361 | |4;audio-oscillator;97;96;150;96;97;95;149;96;95;147 01:33:42 INFO - PROCESS | 4361 | |5;imaging-gaussian-blur;119;115;115;116;115;115;115;115;114;115 01:33:42 INFO - PROCESS | 4361 | |6;imaging-darkroom;145;145;145;145;146;145;145;145;146;146 01:33:42 INFO - PROCESS | 4361 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;96 01:33:42 INFO - PROCESS | 4361 | |8;json-parse-financial;56;56;57;57;55;57;57;64;54;56 01:33:42 INFO - PROCESS | 4361 | |9;json-stringify-tinderbox;68;67;68;68;68;68;77;70;70;68 01:33:42 INFO - PROCESS | 4361 | |10;stanford-crypto-aes;83;84;83;85;83;85;84;84;85;85 01:33:42 INFO - PROCESS | 4361 | |11;stanford-crypto-ccm;118;118;120;120;123;119;121;127;122;120 01:33:42 INFO - PROCESS | 4361 | |12;stanford-crypto-pbkdf2;159;145;167;155;146;147;159;151;145;161 01:33:42 INFO - PROCESS | 4361 | |13;stanford-crypto-sha256-iterative;72;69;72;71;73;70;70;70;70;74 01:33:42 INFO - PROCESS | 4361 | __end_tp_report 01:33:42 INFO - PROCESS | 4361 | __start_cc_report 01:33:42 INFO - PROCESS | 4361 | _x_x_mozilla_cycle_collect,1098 01:33:42 INFO - PROCESS | 4361 | __end_cc_report 01:33:42 INFO - PROCESS | 4361 | __startTimestamp1456392822600__endTimestamp 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | ------- Summary: start ------- 01:33:42 INFO - PROCESS | 4361 | Number of tests: 14 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.50 stddev:4.18 (3.8%) stddev-sans-first:4.43 01:33:42 INFO - PROCESS | 4361 | Values: 109.0 111.0 104.0 109.0 110.0 112.0 98.0 109.0 109.0 111.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.00 stddev:17.03 (11.2%) stddev-sans-first:17.98 01:33:42 INFO - PROCESS | 4361 | Values: 151.0 129.0 154.0 160.0 131.0 151.0 153.0 127.0 179.0 129.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 01:33:42 INFO - PROCESS | 4361 | Values: 162.0 162.0 161.0 161.0 162.0 160.0 161.0 165.0 163.0 161.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#3] audio-fft Cycles:10 Average:85.00 Median:73.50 stddev:15.66 (21.3%) stddev-sans-first:16.10 01:33:42 INFO - PROCESS | 4361 | Values: 74.0 73.0 102.0 99.0 73.0 73.0 74.0 113.0 96.0 73.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:96.00 stddev:25.46 (26.5%) stddev-sans-first:26.43 01:33:42 INFO - PROCESS | 4361 | Values: 97.0 96.0 150.0 96.0 97.0 95.0 149.0 96.0 95.0 147.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 01:33:42 INFO - PROCESS | 4361 | Values: 119.0 115.0 115.0 116.0 115.0 115.0 115.0 115.0 114.0 115.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:33:42 INFO - PROCESS | 4361 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:33:42 INFO - PROCESS | 4361 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.69 (4.7%) stddev-sans-first:2.83 01:33:42 INFO - PROCESS | 4361 | Values: 56.0 56.0 57.0 57.0 55.0 57.0 57.0 64.0 54.0 56.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:68.00 stddev:2.90 (4.3%) stddev-sans-first:3.04 01:33:42 INFO - PROCESS | 4361 | Values: 68.0 67.0 68.0 68.0 68.0 68.0 77.0 70.0 70.0 68.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:0.88 (1.0%) stddev-sans-first:0.83 01:33:42 INFO - PROCESS | 4361 | Values: 83.0 84.0 83.0 85.0 83.0 85.0 84.0 84.0 85.0 85.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:120.50 stddev:2.70 (2.2%) stddev-sans-first:2.67 01:33:42 INFO - PROCESS | 4361 | Values: 118.0 118.0 120.0 120.0 123.0 119.0 121.0 127.0 122.0 120.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:157.00 stddev:7.82 (5.0%) stddev-sans-first:8.04 01:33:42 INFO - PROCESS | 4361 | Values: 159.0 145.0 167.0 155.0 146.0 147.0 159.0 151.0 145.0 161.0 01:33:42 INFO - PROCESS | 4361 | 01:33:42 INFO - PROCESS | 4361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.60 (2.2%) stddev-sans-first:1.66 01:33:42 INFO - PROCESS | 4361 | Values: 72.0 69.0 72.0 71.0 73.0 70.0 70.0 70.0 70.0 74.0 01:33:42 INFO - PROCESS | 4361 | -------- Summary: end -------- 01:33:42 INFO - PROCESS | 4361 | 01:33:43 INFO - TEST-INFO | 4361: exit 0 01:33:43 INFO - TEST-OK | kraken | took 60550ms 01:33:43 INFO - SUITE-END | took 1173s 01:33:43 INFO - Completed test suite (00:19:34) 01:33:43 INFO - Working with test: dromaeo_css 01:33:43 INFO - Generating results file: dromaeo_css 01:33:43 INFO - Working with test: kraken 01:33:43 INFO - Generating results file: kraken 01:33:43 INFO - javascript benchmark 01:33:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:33:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 01:33:43 INFO - process_Request line: dromaeo_css 6824.03 graph.html#tests=[[72,63,35]] 01:33:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:33:43 INFO - process_Request line: kraken 1525.40 graph.html#tests=[[232,63,35]] 01:33:43 INFO - RETURN: dromaeo_css: 6824.03 01:33:43 INFO - RETURN: kraken: 1525.40 01:33:43 INFO - javascript benchmark 01:33:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3155.384699983503, 3178.126015345781, 3213.3412650406667, 3226.6450690424062, 3249.3826173027132, 5077.64456488045, 5102.3111879896205, 5132.43543210247, 5150.356205474316, 5173.741312934352, 5160.483951604838, 5185.144451165553, 5193.766280517376, 5208.531232189102, 5278.313819203508, 4659.254519276917, 4728.361671174391, 4778.952210477903, 4797.784099715521, 4831.903361932759, 4639.884002899921, 4701.059788042405, 4758.857234282977, 4766.523347665223, 4887.315775791392, 4751.786169622375, 4766.070616229837, 4766.499517550642, 4782.689125206851, 4811.615070794345, 4759.50025247351, 4784.378030856001, 4787.16224660683, 4794.49657785931, 4815.542523460265, 4658.091672123937, 4682.8126874924965, 4780.306855505967, 4781.306710526954, 4810.11012962603, 5086.669366491166, 5096.362954630671, 5100.413452452941, 5119.2321151827155, 5124.385073791132, 5572.080606699889, 5586.190002449663, 5590.888182236333, 5593.077142271521, 5631.60578759487, 5528.308961379827, 5608.158776183564, 5613.438656134354, 5676.659400435987, 5679.034564124109, 5273.235380869753, 5298.36419629643, 5299.0, 5324.0150572144275, 5326.041312563737, 5754.539636829044, 5770.278715160605, 5777.768889244468, 5788.363280039192, 5790.189373487715, 5388.084025715638, 5481.013417584793, 5548.278723765885, 5575.414581468968, 5599.664020158803, 5575.526080283222, 5578.804741834017, 5580.944190558123, 5582.0, 5586.385497595261, 5380.058489764276, 5553.694546799884, 5553.8333849984565, 5557.194206840067, 5604.859878502988, 5483.506484416422, 5536.0, 5536.584756143306, 5559.444055594408, 5588.972055139699, 4360.367746676714, 4372.366006929041, 4378.2119218540965, 4386.824527018884, 4420.138073075784, 3823.4647149399107, 3860.208657225262, 3919.1573811630637, 3924.3132451820816, 3944.2111577684577, 5253.55344795689, 5266.815661451831, 5273.472652734696, 5274.525292723673, 5320.76056577455, 5620.662760234399, 5642.125470552071, 5649.915251271234, 5651.773929042874, 5652.886942261214, 5093.8726531837, 5195.584353251731, 5265.104932161542, 5268.868278292996, 5296.443873393316, 4722.456917454537, 4749.738764367993, 4751.263554149113, 4763.904721905612, 4789.736564488987, 5720.141978703145, 5741.1388291756575, 5743.655380677173, 5749.798757043483, 5752.626079304831, 5460.6177567569885, 5493.642913210789, 5543.944560554342, 5596.0206963780365, 5620.044592419216, 5732.340780810094, 5734.168545560787, 5734.741936612946, 5741.0, 5743.684097374685, 5415.675059496442, 5417.945820541744, 5422.5119739223655, 5426.782928682808, 5468.507834294933, 5444.891102177855, 5556.472135147154, 5617.943820561742, 5625.46558076982, 5649.85875353103, 5490.5882058844945, 5492.368377636623, 5513.972430137824, 5517.668939863621, 5521.447855214607, 5345.786168553214, 5496.450354964471, 5516.448355164452, 5520.447955204448, 5554.1946417770005, 5388.865278368072, 5421.403645598902, 5421.5391691706645, 5428.864278393072, 5475.233467314659, 5445.83662490126, 5447.400785913625, 5471.644343117685, 5473.534749546333, 5474.808381706621, 5248.475152484721, 5347.705876176848, 5356.0, 5363.141897296414, 5363.463653634605], "unit": "score", "name": "dojo.html", "value": 5158.056020263316}, {"lowerIsBetter": false, "replicates": [515.1962937817005, 529.6292595183371, 534.9251104845322, 539.8380485854243, 551.4320250142354, 28521.572176417343, 37293.81353093234, 37479.250414991686, 37493.0, 37624.43563346549, 40378.19243615133, 40819.591804082025, 40860.79569602148, 40869.795651021705, 40954.0, 8425.1153628869, 8649.827003459926, 8661.610227539775, 8662.696805611804, 8669.436486628381, 8340.499570025819, 8453.239208471236, 8464.957675211615, 8470.534120623362, 8636.309095272394, 8654.134586541359, 8715.128487151265, 8718.389712720113, 8720.781980450476, 8723.476591404504, 8600.22597966183, 8636.136386361377, 8655.913440865574, 8664.133586641348, 8671.609777560025, 8611.741647750578, 8695.478271303742, 8717.825643487158, 8733.170348816851, 8739.300855931573, 40117.398239026435, 40567.59432405697, 40597.39103913444, 40608.79695601533, 40668.0, 3310.8841190558214, 3543.982280088583, 3609.873654422083, 3707.5921648618632, 3911.7261791674596, 30424.391512169856, 30539.847300763577, 30624.77500899961, 30779.538306925413, 30822.53766193509, 3847.826847791856, 3914.6868250540174, 3919.431682406064, 3935.2129574085297, 3936.980315098435, 261592.0, 262885.9999999981, 263136.0, 263271.0, 263925.0, 59910.10134847981, 60014.399856000884, 60295.0, 60309.39690603125, 60376.39623603708, 62383.37616623867, 62586.0, 64792.0, 65709.0, 65729.34270657328, 16441.588960276087, 16637.584060398585, 16674.58313542171, 16688.916555417145, 16719.080450575093, 12575.496980120693, 12621.747565048647, 12642.494300228072, 12665.113442058968, 12670.0, 19968.50078748043, 20203.292884748964, 20231.393058208276, 20245.392638220877, 20277.391678249674, 7980.162082981319, 8150.592470376458, 8312.6674933002, 8352.12302708219, 8357.247847693616, 864.8400045991386, 886.8581027035643, 919.632147141149, 934.2525979216599, 1027.2295778166376, 24772.132975345776, 25357.239282821545, 25480.23559293224, 25515.234542963368, 27006.0, 955.1833182628891, 977.9266555008261, 1020.1736593359402, 1022.4580972084658, 1042.2131290875493, 12689.428975696115, 13032.0, 13086.411111500005, 13095.083344166007, 13110.213387196798, 358000.0, 358223.0, 362131.0, 362201.0, 363345.0, 54392.45607543953, 54598.727006364716, 55134.0, 55227.72386138044, 55342.44657553373, 1190.8809119088196, 1282.33959510852, 1286.7169222770976, 1365.7405093032291, 1398.223985687953, 24222.515549688556, 24275.271741847773, 24428.0, 24436.755632444158, 24468.0, 38432.0, 38689.22621547497, 38702.22595548017, 39376.803115984236, 39583.20833583255, 166997.0, 168127.1593642073, 174731.0, 176253.0, 176478.11760941113, 27591.31021724473, 31757.8412107938, 32208.677913220567, 32407.027789166365, 32611.673883260864, 38033.0, 38070.2385952285, 38421.61578384292, 38523.42214866835, 39106.804465978625, 32415.0, 32526.34947301088, 32726.836365818017, 35032.474512882836, 35520.82239588785, 32751.672483274862, 34740.305193895474, 35150.824245878604, 35168.29663406769, 35645.28709425745, 29936.70063299339, 30334.84832575823, 30749.53875691911, 30788.0, 30945.0, 29012.843890433443, 31101.844490777403, 32182.19544511406, 32202.83898580492, 32278.35443291074, 21208.575828483652, 21382.893085534473, 21437.142514299252, 21487.785122149206, 21567.676484852425], "unit": "score", "name": "ext.html", "value": 17719.470982843497}, {"lowerIsBetter": false, "replicates": [355.9537260156181, 359.72481051995226, 365.8993776711404, 366.89543480108176, 371.0131051403268, 16795.916020419896, 17254.82745172548, 17480.38818641348, 17819.46541603754, 17822.46532604024, 10987.61543345983, 11356.716082097952, 11376.0, 11378.772424551504, 16356.1004144772, 4898.828541001057, 5008.774605142759, 5009.649324547283, 5041.899162016776, 5045.672031317952, 4928.236123400879, 5030.522100400456, 5041.596672266228, 5066.569341605949, 5067.797288108472, 5029.0, 5034.773435195425, 5038.521340472649, 5039.899202015958, 5084.288199652052, 5065.898682026357, 5210.843674689746, 5436.537894278991, 5439.075357189287, 5445.237666726662, 5206.427292997767, 5211.5049070338255, 5215.452377500345, 5221.686698798047, 5235.869103272411, 14157.929210353985, 20144.89927550353, 20727.27454539099, 20747.170113195603, 20762.169513219455, 2077.8233850122756, 2118.343313572782, 2482.91309804156, 2597.779188768957, 2747.958780618292, 9352.859707104399, 9416.670416535457, 9671.274654400877, 9748.220142388593, 12284.692882677915, 1773.813749556291, 1798.7481752554652, 1802.9098545072693, 1810.0, 1822.6263615958696, 62197.68901155511, 65991.34008659948, 66910.33089669139, 67321.66339168273, 67887.66056169737, 10179.592816287266, 10187.08316251541, 10452.275374563264, 10452.372857628567, 10530.473476326153, 13850.376733047036, 13915.512957046454, 13916.791248131287, 13923.930380348034, 13937.024408291321, 7418.109826820816, 7657.119431265364, 7659.885101723478, 7749.7675069748, 7759.068911730628, 7354.448416368794, 7430.145533263744, 7496.362809161174, 7515.398768098539, 7538.057742782153, 4456.866294011184, 4459.598636122764, 4498.887527811766, 4604.976975115103, 4627.976860115745, 1730.3338214787145, 1735.4706814421722, 1752.325354738435, 1774.8313910178513, 1775.6182420779594, 848.2874385516196, 859.9140085991476, 900.2572877376191, 906.7279816055157, 937.3906960475609, 14869.702605947821, 15149.365883175675, 15402.614934626725, 15569.143697096768, 15683.0, 867.6312567158932, 878.9428687135315, 886.822635472908, 888.1583832943164, 921.6958403726754, 8554.91445085541, 8682.86975695365, 8723.345749068845, 8783.989841168348, 8847.159519845605, 391793.0, 396799.0, 406038.0, 408070.0, 409105.0, 56629.0, 66305.6684716583, 67887.3211267881, 73913.26086739171, 77637.223627763, 968.2786324188525, 971.223021582731, 990.3117333453181, 994.3089552760762, 1020.2144348851491, 13854.792178117537, 14195.077319974169, 14276.357563909442, 14421.855781442051, 14522.85477145215, 31748.523772143897, 33870.153246169044, 34560.308793824486, 34723.95703222583, 34904.0, 45410.77294613506, 46039.07921841477, 47046.76476617595, 47789.283160753315, 47790.283145752146, 7952.244536768998, 8003.799905002422, 8058.637361318638, 8116.472429292077, 8194.426390152632, 9662.323637345318, 12303.200291980993, 12525.37373131358, 12788.744225115632, 12800.16798908068, 9867.950660246654, 9892.0, 9984.450855203033, 10447.268691191544, 10819.188560858125, 10637.255392122477, 10658.786824263316, 10663.8933610666, 10704.357738535713, 10802.297850639683, 8860.538011228075, 8889.688860889837, 10308.0, 10606.098481629147, 10850.837237441287, 8012.83974320522, 8026.478278912085, 8084.39367047462, 8174.918250817415, 8241.83516329682, 9961.900380996098, 10407.427591482541, 10497.842532362174, 10586.947065264625, 10596.8940310599], "unit": "score", "name": "jquery.html", "value": 8130.716966758757}, {"lowerIsBetter": false, "replicates": [1388.1393536007665, 1499.160470136724, 1501.7597184450487, 1688.4850120713186, 1830.368522859614, 7530.774076777699, 7698.384129269659, 7737.690492380305, 7738.767836964893, 7746.573938433398, 7586.279303466175, 7772.417068719855, 7789.376849852012, 7794.532328060321, 7798.999999999985, 2021.312753663754, 2058.5779915117364, 2228.487447886987, 2261.061659411346, 2290.3701482092392, 2259.2544460328054, 2265.365697604665, 2268.5009297954425, 2270.2735124760084, 2271.068861766676, 2186.35502526755, 2212.225720997654, 2218.4453886528368, 2265.8300627452923, 2269.205777977703, 2158.6006588781124, 2223.3107736601623, 2227.6658501224783, 2231.9107235710553, 2231.9218827341047, 2151.774063723318, 2167.3822960456196, 2168.4036889855256, 2170.522485053286, 2171.880546569938, 7940.761777146695, 7987.720429784988, 7994.440389172761, 8009.919900801034, 8015.519068855829, 4667.369905062807, 4758.690685105457, 4790.712557246541, 4795.520447955211, 4796.136695394827, 2938.808977416461, 2946.5138252188362, 3035.195673146618, 3049.7560195184333, 3050.7864449488325, 927.9304052196045, 933.9159475647224, 938.3290946972879, 964.8022155458115, 976.3117002513211, 10797.244192906499, 10814.35113893169, 10828.025477706966, 10839.241253112285, 10844.0, 4197.853075142355, 4240.915181696349, 4309.978450107792, 4324.394584758136, 4325.891852703708, 9086.136817002374, 9093.0, 9105.453672779655, 9116.0, 9126.315526335418, 4756.6432517561325, 4759.857204283877, 4793.041391721669, 4793.089313030513, 4795.688280261772, 3978.741381810173, 3981.900452488711, 4014.658754005884, 4223.894402639959, 4358.346248062816, 3506.7369947253546, 3601.6218297078954, 3610.6028336882923, 3625.9456108158397, 3655.6892664123848, 1163.790517706804, 1166.2069792541154, 1167.7080729817546, 1185.04603793945, 1185.7035741064733, 1324.589377293023, 1326.8407791065133, 1327.6481732340937, 1360.251861476184, 1372.4167228927665, 7251.492395532262, 7496.850062998709, 7536.623168841646, 7606.695732170651, 7636.847263054708, 1144.553624086607, 1145.0782120393164, 1145.8166693329194, 1150.1316506038056, 1151.8445009923553, 5693.28833895763, 5774.624649397776, 5829.154772557956, 5835.94164058354, 5838.007538718428, 8905.510196939102, 9281.535923203814, 9381.812363752686, 9416.811663766823, 9563.330566860253, 9263.25893928484, 9360.90639093614, 9416.43501389905, 9450.810983780424, 9452.291078169164, 7295.197528271886, 7406.629668516661, 7421.257874212643, 7438.0, 7494.288042635941, 7230.530015548972, 7271.3455788979245, 7274.381677557467, 7275.054242948383, 7294.63526823646, 8238.752837414888, 8326.167383261625, 8407.327413807003, 8514.807926890117, 8573.957130214309, 8352.41533092702, 8468.66125354979, 8497.74506764798, 8529.530875801891, 8630.697925572826, 6383.202099737533, 6458.128152699325, 6613.107230523818, 6708.6310252936555, 6771.729130834909, 7540.924590754023, 7592.126905405949, 7621.428392870446, 7622.9237707622215, 7632.045994250719, 6651.567648103051, 6911.723531058701, 6945.166580010431, 6955.686994085379, 7071.25751796054, 6780.660966951534, 6807.931920680928, 6864.279250678607, 6892.276310987475, 6951.652417379212, 6846.452283817183, 6907.930920690729, 6914.135733033371, 6962.373386395248, 7089.680964356513, 6576.638284894377, 6579.638119903259, 6607.075009498578, 6614.173228346457, 6623.3376662333385, 6461.386168314003, 6565.179352580927, 6612.933870661232, 6617.272100069084, 6619.040239165391], "unit": "score", "name": "mootools.html", "value": 4490.7935822216}, {"lowerIsBetter": false, "replicates": [339.91332210286373, 345.71823963469774, 350.07754566716704, 354.9591796943352, 355.98220088995544, 5870.236869207008, 5873.882522349556, 5916.319623243328, 5940.524758019348, 5983.072623743326, 5834.241548598677, 5836.970815145929, 5837.678927658977, 5844.795432159875, 5848.093545500444, 4381.123775244956, 4409.889752756175, 4483.663725220606, 4488.775561221943, 4498.0, 4471.843485478009, 4486.125205584913, 4486.1700585391645, 4490.101979604092, 4492.2812350024005, 4364.127174565084, 4477.238869392211, 4501.3022981437925, 4509.210888094571, 4516.1193567254395, 4440.134173836087, 4440.600345968878, 4445.399871017404, 4503.301988191835, 4522.570355816192, 3972.2651309507546, 3980.7611543307203, 3982.9402558961638, 3994.2610617035944, 3995.4406383106098, 5524.419935906712, 5528.032594296023, 5537.36320323164, 5598.832035038955, 5611.494965453129, 5275.235090911835, 5288.8413347599635, 5292.52367286946, 5301.867453313659, 5313.787448502056, 6217.906731398987, 6225.87548249037, 6233.376662333776, 6233.594816336924, 6236.65911828959, 4191.580841915815, 4269.679774016961, 4284.250256205183, 4284.635805956466, 4470.441194850644, 6418.486521078303, 6471.5146364022885, 6482.805515834532, 6502.349765023459, 6504.349565043505, 4397.098594788061, 4412.624926881187, 4429.645628349725, 4438.955610443919, 4452.710573812692, 4496.437945256843, 4501.41481607389, 4502.977485112619, 4503.369528266046, 4506.909861802811, 5160.896782064413, 5166.664166829144, 5179.663321884141, 5189.532942035235, 5191.532762051434, 6050.6369617823075, 6244.438000579969, 6246.937530624727, 6266.874662506724, 6313.053042043638, 1554.432632089302, 1581.683663267328, 1591.283922234999, 1592.896461729984, 1593.8246792852776, 987.5457289646843, 990.3958585262984, 1004.7036124343336, 1054.1250761867632, 1078.0513148429332, 5947.04847224442, 5961.5230781537375, 5961.986462301419, 5967.045272756338, 5971.462568368867, 6417.903731444032, 6424.229092508929, 6430.871382572416, 6435.292117867031, 6438.066480360321, 5926.140709597084, 5941.494972927349, 5952.0476723724, 5953.0, 5959.046552551571, 3425.3320602482277, 3432.1076520104452, 3441.913952151216, 3452.0, 3456.118689734152, 6600.504962127764, 6688.933110668831, 6701.966490167518, 6823.863522729517, 6864.931350686529, 6672.366125218096, 6711.932880671131, 6717.227518835299, 6719.764808231688, 6721.1598550181225, 6822.556533825385, 6827.658617069127, 6845.041694162821, 6849.1438570178725, 6849.349311815369, 6498.675066246763, 6501.479881609365, 6513.218413790375, 6516.152900122954, 6527.0, 6253.968730156502, 6452.580582262138, 6459.257185423737, 6464.612123272431, 6492.675366231764, 6712.597244165366, 6755.93244067553, 6769.796906092825, 6778.186617605918, 6844.178698556205, 4466.620337271238, 4502.954970450384, 4506.639468842419, 4507.5943165115295, 4509.90980180388, 6534.771283005072, 6541.672916354259, 6542.411182993554, 6543.967280163569, 6553.279139294769, 6368.299487056327, 6376.458001069961, 6411.4870810336, 6413.0, 6417.7753778617525, 6171.1668924694595, 6327.209098862642, 6345.0482427636225, 6363.204599425072, 6365.840853978688, 6196.0705894116245, 6218.378162183745, 6238.532110091852, 6239.0953311770445, 6243.157173781481, 6376.298607153117, 6383.6808159592765, 6384.9042264367, 6385.169927909528, 6394.2646595640235, 5945.3757355477055, 6072.362401947732, 6212.627242365473, 6218.253809542884, 6225.8132256032395], "unit": "score", "name": "prototype.html", "value": 4734.30228467069}, {"lowerIsBetter": false, "replicates": [725.7895210388984, 735.4998600951352, 735.8896165575167, 785.7996210966203, 820.6430202861756, 13087.672808179801, 13236.801447978289, 13249.470021199164, 13250.403731832066, 13290.933545332271, 13119.47522099115, 13131.606051818437, 13137.868621313808, 13141.408636611375, 13154.342282885842, 686.7733647896182, 805.114374188391, 830.4767996162409, 841.3311417423163, 844.624142256696, 817.3012074676155, 823.7528741377592, 827.2472050434106, 828.1387357148558, 828.9709860154895, 868.079835374505, 879.6525372477868, 879.6965047058786, 880.7886107334226, 881.1496905486205, 700.7127077898062, 861.3841103610916, 878.6046279174333, 878.8242351529688, 879.0725784297564, 640.9487241020707, 645.3062957320899, 650.5738741124571, 651.8500744828716, 652.5138771615129, 12694.428750706147, 12755.936220318932, 12802.679933001657, 12825.807612885814, 12839.679008024781, 12848.935755321258, 13045.804312935219, 13141.934290328583, 13145.145565538305, 13360.599182024554, 10654.62708805188, 10766.892331076746, 10785.46072696362, 10893.291936024134, 10913.727156821064, 3593.4969104325414, 3627.9274414511824, 3650.5984341722387, 3673.3938900081453, 3783.697304215656, 47964.0, 48167.75916120432, 48936.26595601069, 48981.0, 49673.751631241976, 9225.53872306382, 9369.437833729999, 9377.906220937839, 9490.383125096847, 9841.45871977048, 16971.575710607332, 17245.482635520955, 18526.795758275668, 18701.0, 18706.06469676511, 7567.962160189274, 7659.0, 7670.693172273158, 7687.692492300357, 7708.03649543807, 4480.126375356775, 4488.236999710057, 4519.570640789119, 4619.076184763061, 4654.534546545387, 3148.5592017117624, 3157.984210078981, 3171.952420713691, 3177.189816596753, 3179.42770301348, 580.274656679151, 587.8471597384711, 588.4674369695432, 596.9970150149221, 621.0094898636668, 561.8370672504927, 605.4944121658465, 643.1960049937578, 672.2605134352272, 687.8314812870879, 8303.377246706521, 8547.914520854712, 8634.827303453896, 8786.516741579147, 8891.155340242796, 658.1079396734389, 660.920689517261, 685.1948959972013, 695.600029982762, 706.9681864316118, 3876.9418458723144, 4052.797360131982, 4108.548059713429, 4158.563350848178, 4221.64116050133, 52765.0, 53126.734366327924, 53194.73402632962, 57319.42680573224, 58712.41287587155, 44062.33906491405, 45286.77356613196, 45500.77249613731, 45727.542724572326, 45989.310160346955, 41686.58313416827, 41968.79015604902, 42595.0, 43679.56320436755, 43762.12475750467, 8536.0, 8634.611442484978, 8785.428947118417, 8816.382853200214, 8837.293016558531, 35633.28733425369, 35933.0, 36734.63265367312, 37277.25445491129, 37667.623323767504, 47893.28160077671, 48052.03895922132, 48269.75865120652, 48855.75572122117, 49922.75038624783, 11515.374737449774, 11964.64106076819, 12011.879881201075, 12061.577844775391, 12694.746105078031, 12320.445579949102, 12359.3820308986, 12846.935765321114, 13055.0, 13220.735585288432, 11941.52233910634, 12039.518419263482, 12300.753984920431, 12433.0, 12715.745685086431, 11758.176927614984, 12014.879851201376, 12116.21244619097, 12442.688932776753, 12752.298623575793, 11798.11514136426, 12052.337121458404, 12207.816882746589, 12541.435635396247, 12586.937065314614, 9486.667966621135, 9622.615095396106, 9859.654912078044, 9999.400035997864, 10088.546015429176, 8704.0, 9339.719808405758, 9362.672306469241, 9667.758306042406, 9784.51077446139], "unit": "score", "name": "yui.html", "value": 6390.936600224828}], "name": "dromaeo_css", "value": 6824.030857248484}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 110.0, 112.0, 98.0, 109.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [151.0, 129.0, 154.0, 160.0, 131.0, 151.0, 153.0, 127.0, 179.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 160.0, 161.0, 165.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 102.0, 99.0, 73.0, 73.0, 74.0, 113.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 150.0, 96.0, 97.0, 95.0, 149.0, 96.0, 95.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 111.8}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 57.0, 55.0, 57.0, 57.0, 64.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 77.0, 70.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 85.0, 83.0, 85.0, 84.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 120.0, 120.0, 123.0, 119.0, 121.0, 127.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [159.0, 145.0, 167.0, 155.0, 146.0, 147.0, 159.0, 151.0, 145.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.5}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 72.0, 71.0, 73.0, 70.0, 70.0, 70.0, 70.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1525.3999999999999}]} 01:33:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1525.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6824.03"}}} 01:33:44 INFO - Return code: 0 01:33:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:33:44 INFO - # TBPL SUCCESS # 01:33:44 INFO - Running post-action listener: _resource_record_post_action 01:33:44 INFO - Running post-run listener: _resource_record_post_run 01:33:45 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536694784; Read time: 360; Write time: 513192 01:33:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240766976; Read time: 116; Write time: 274136 01:33:45 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295927808; Read time: 244; Write time: 239056 01:33:45 INFO - Running post-run listener: _upload_blobber_files 01:33:45 INFO - Blob upload gear active. 01:33:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:33:45 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 01:33:45 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:33:45 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:33:45 INFO - (blobuploader) - INFO - Open directory for files ... 01:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:33:46 INFO - (blobuploader) - INFO - Done attempting. 01:33:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:33:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:33:47 INFO - (blobuploader) - INFO - Done attempting. 01:33:47 INFO - (blobuploader) - INFO - Iteration through files over. 01:33:47 INFO - Return code: 0 01:33:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:33:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:33:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b059d6270becdad3c9168b88ca38b08eb2070ee4db8cbbad68c3230f28cc643f2485b34fa7b29638a80ced847eb6473a006983657e2a5fb15536363b1ec60bfb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41db8d2bb5ec7e8f4af31caa2c968a5bed839c38b6c06845152d848076245400d20224967a4110a9a6ebe98956026fe119da98fa3aac7b27667e5b05651d924"} 01:33:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:33:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:33:47 INFO - Contents: 01:33:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b059d6270becdad3c9168b88ca38b08eb2070ee4db8cbbad68c3230f28cc643f2485b34fa7b29638a80ced847eb6473a006983657e2a5fb15536363b1ec60bfb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41db8d2bb5ec7e8f4af31caa2c968a5bed839c38b6c06845152d848076245400d20224967a4110a9a6ebe98956026fe119da98fa3aac7b27667e5b05651d924"} 01:33:47 INFO - Running post-run listener: copy_logs_to_upload_dir 01:33:47 INFO - Copying logs to upload dir... 01:33:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:33:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.748509 ========= master_lag: 49.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-25 01:34:36.133950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-25 01:34:36.137722) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b059d6270becdad3c9168b88ca38b08eb2070ee4db8cbbad68c3230f28cc643f2485b34fa7b29638a80ced847eb6473a006983657e2a5fb15536363b1ec60bfb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41db8d2bb5ec7e8f4af31caa2c968a5bed839c38b6c06845152d848076245400d20224967a4110a9a6ebe98956026fe119da98fa3aac7b27667e5b05651d924"} build_url:https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011500 build_url: 'https://queue.taskcluster.net/v1/task/PcnCeftYQeaKangfVOojaQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b059d6270becdad3c9168b88ca38b08eb2070ee4db8cbbad68c3230f28cc643f2485b34fa7b29638a80ced847eb6473a006983657e2a5fb15536363b1ec60bfb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41db8d2bb5ec7e8f4af31caa2c968a5bed839c38b6c06845152d848076245400d20224967a4110a9a6ebe98956026fe119da98fa3aac7b27667e5b05651d924"}' ========= master_lag: 1.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-25 01:34:37.293779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:34:37.294098) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456391596.656355-952300218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 01:34:37.320186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:34:37.320508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 01:34:37.320814) ========= ========= Total master_lag: 50.51 =========