builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1453521468.25 results: success (0) buildid: 20160122173011 builduid: 2c6232fb92a54c2486112c98cbf70385 revision: 361fd7db4ba38bc8954e168b142294e077e96591 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.251846) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.252268) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.252599) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.281105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.281444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.300188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.300495) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.349828) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.350163) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.350585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.350981) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 19:57:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-22 19:57:49 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.447360 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.814962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.815300) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018771 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.865854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:48.866238) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 361fd7db4ba38bc8954e168b142294e077e96591 --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/b2g-inbound --rev 361fd7db4ba38bc8954e168b142294e077e96591 --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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 19:57:49,411 truncating revision to first 12 chars 2016-01-22 19:57:49,411 Setting DEBUG logging. 2016-01-22 19:57:49,411 attempt 1/10 2016-01-22 19:57:49,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/361fd7db4ba3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 19:57:50,042 unpacking tar archive at: b2g-inbound-361fd7db4ba3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:49.817565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:49.818282) ========= echo 361fd7db4ba38bc8954e168b142294e077e96591 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'361fd7db4ba38bc8954e168b142294e077e96591'] 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 361fd7db4ba38bc8954e168b142294e077e96591 program finished with exit code 0 elapsedTime=0.004694 script_repo_revision: '361fd7db4ba38bc8954e168b142294e077e96591' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:49.873880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:49.874233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 19:57:49.888213) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-22 19:57:49.888564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:57:50 INFO - MultiFileLogger online at 20160122 19:57:50 in /builds/slave/test-pgo 19:57:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:57:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:57:50 INFO - {'append_to_log': False, 19:57:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:57:50 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:57:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:57:50 INFO - 'branch': 'B2G-Inbound', 19:57:50 INFO - 'buildbot_json_path': 'buildprops.json', 19:57:50 INFO - 'config_files': ('talos/linux_config.py',), 19:57:50 INFO - 'default_actions': ('clobber', 19:57:50 INFO - 'read-buildbot-config', 19:57:50 INFO - 'download-and-extract', 19:57:50 INFO - 'populate-webroot', 19:57:50 INFO - 'create-virtualenv', 19:57:50 INFO - 'install', 19:57:50 INFO - 'run-tests'), 19:57:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:57:50 INFO - 'download_minidump_stackwalk': True, 19:57:50 INFO - 'download_symbols': 'ondemand', 19:57:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:57:50 INFO - 'tooltool.py': '/tools/tooltool.py', 19:57:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:57:50 INFO - '/tools/misc-python/virtualenv.py')}, 19:57:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:57:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:57:50 INFO - 'installer_path': 'installer.exe', 19:57:50 INFO - 'log_level': 'info', 19:57:50 INFO - 'log_name': 'talos', 19:57:50 INFO - 'log_to_console': True, 19:57:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:57:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:57:50 INFO - 'opt_config_files': (), 19:57:50 INFO - 'pip_index': False, 19:57:50 INFO - 'sps_profile': False, 19:57:50 INFO - 'sps_profile_interval': 0, 19:57:50 INFO - 'suite': 'dromaeojs', 19:57:50 INFO - 'system_bits': '32', 19:57:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:57:50 INFO - 'title': 'talos-linux64-ix-067', 19:57:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:57:50 INFO - 'use_talos_json': True, 19:57:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:57:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:57:50 INFO - 'work_dir': 'build'} 19:57:50 INFO - ##### 19:57:50 INFO - ##### Running clobber step. 19:57:50 INFO - ##### 19:57:50 INFO - Running pre-action listener: _resource_record_pre_action 19:57:50 INFO - Running main action method: clobber 19:57:50 INFO - rmtree: /builds/slave/test-pgo/build 19:57:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:57:50 INFO - Running post-action listener: _resource_record_post_action 19:57:50 INFO - ##### 19:57:50 INFO - ##### Running read-buildbot-config step. 19:57:50 INFO - ##### 19:57:50 INFO - Running pre-action listener: _resource_record_pre_action 19:57:50 INFO - Running main action method: read_buildbot_config 19:57:50 INFO - Using buildbot properties: 19:57:50 INFO - { 19:57:50 INFO - "project": "", 19:57:50 INFO - "product": "firefox", 19:57:50 INFO - "script_repo_revision": "production", 19:57:50 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:57:50 INFO - "repository": "", 19:57:50 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:57:50 INFO - "buildid": "20160122173011", 19:57:50 INFO - "pgo_build": "True", 19:57:50 INFO - "basedir": "/builds/slave/test-pgo", 19:57:50 INFO - "buildnumber": 1128, 19:57:50 INFO - "slavename": "talos-linux64-ix-067", 19:57:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:57:50 INFO - "platform": "ubuntu64_hw", 19:57:50 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:57:50 INFO - "branch": "b2g-inbound", 19:57:50 INFO - "repo_path": "integration/b2g-inbound", 19:57:50 INFO - "revision": "361fd7db4ba38bc8954e168b142294e077e96591", 19:57:50 INFO - "stage_platform": "linux64-pgo", 19:57:50 INFO - "builduid": "2c6232fb92a54c2486112c98cbf70385", 19:57:50 INFO - "slavebuilddir": "test" 19:57:50 INFO - } 19:57:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:57:50 INFO - Running post-action listener: _resource_record_post_action 19:57:50 INFO - ##### 19:57:50 INFO - ##### Running download-and-extract step. 19:57:50 INFO - ##### 19:57:50 INFO - Running pre-action listener: _resource_record_pre_action 19:57:50 INFO - Running main action method: download_and_extract 19:57:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:50 INFO - https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:57:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/test_packages.json 19:57:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/test_packages.json 19:57:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:57:51 INFO - Downloaded 1448 bytes. 19:57:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:57:51 INFO - Using the following test package requirements: 19:57:51 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:57:51 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:57:51 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:57:51 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'jsshell-linux-x86_64.zip'], 19:57:51 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:57:51 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:57:51 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:57:51 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:57:51 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:57:51 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:57:51 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:51 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:57:51 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:57:51 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')]} 19:57:51 INFO - https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:57:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:57:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:57:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:57:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:57:52 INFO - Downloaded 22488697 bytes. 19:57:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:57:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:57:53 INFO - Return code: 0 19:57:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:57:53 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')]} 19:57:53 INFO - https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:57:55 INFO - Downloaded 22488697 bytes. 19:57:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:57:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:57:56 INFO - Return code: 0 19:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:56 INFO - https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:57:57 INFO - Downloaded 10706572 bytes. 19:57:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:57:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:57:57 INFO - Return code: 0 19:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:57 INFO - https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:57:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:57:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:57:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:57:58 INFO - Downloaded 55968357 bytes. 19:57:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:57:58 INFO - mkdir: /builds/slave/test-pgo/properties 19:57:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:57:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:57:58 INFO - Contents: 19:57:58 INFO - build_url:https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:57:58 INFO - Running post-action listener: _resource_record_post_action 19:57:58 INFO - Running post-action listener: set_extra_try_arguments 19:57:58 INFO - ##### 19:57:58 INFO - ##### Running populate-webroot step. 19:57:58 INFO - ##### 19:57:58 INFO - Running pre-action listener: _resource_record_pre_action 19:57:58 INFO - Running main action method: populate_webroot 19:57:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:57:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:57:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:57:58 INFO - '--tppagecycles', 19:57:58 INFO - '7'], 19:57:58 INFO - 'tests': ['tsvgm']}}, 19:57:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:57:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:57:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:57:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:57:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'tests': ['damp', 'tps']}, 19:57:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['damp', 'tps']}, 19:57:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:57:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:57:58 INFO - 'other': {'tests': ['a11yr', 19:57:58 INFO - 'ts_paint', 19:57:58 INFO - 'tpaint', 19:57:58 INFO - 'sessionrestore', 19:57:58 INFO - 'sessionrestore_no_auto_restore']}, 19:57:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['a11yr', 19:57:58 INFO - 'ts_paint', 19:57:58 INFO - 'tpaint', 19:57:58 INFO - 'sessionrestore', 19:57:58 INFO - 'sessionrestore_no_auto_restore']}, 19:57:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['a11yr', 19:57:58 INFO - 'ts_paint', 19:57:58 INFO - 'tpaint', 19:57:58 INFO - 'sessionrestore', 19:57:58 INFO - 'sessionrestore_no_auto_restore']}, 19:57:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['a11yr', 19:57:58 INFO - 'ts_paint', 19:57:58 INFO - 'tpaint', 19:57:58 INFO - 'sessionrestore', 19:57:58 INFO - 'sessionrestore_no_auto_restore']}, 19:57:58 INFO - 'other_l64': {'tests': ['a11yr', 19:57:58 INFO - 'ts_paint', 19:57:58 INFO - 'tpaint', 19:57:58 INFO - 'sessionrestore', 19:57:58 INFO - 'sessionrestore_no_auto_restore']}, 19:57:58 INFO - 'other_nol64': {'tests': ['a11yr', 19:57:58 INFO - 'ts_paint', 19:57:58 INFO - 'tpaint', 19:57:58 INFO - 'sessionrestore', 19:57:58 INFO - 'sessionrestore_no_auto_restore']}, 19:57:58 INFO - 'svgr': {'tests': ['tsvgx', 19:57:58 INFO - 'tsvgr_opacity', 19:57:58 INFO - 'tart', 19:57:58 INFO - 'tscrollx', 19:57:58 INFO - 'cart']}, 19:57:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['tsvgx', 19:57:58 INFO - 'tsvgr_opacity', 19:57:58 INFO - 'tart', 19:57:58 INFO - 'tscrollx', 19:57:58 INFO - 'cart']}, 19:57:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'tests': ['tp5o']}, 19:57:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'talos_options': ['--e10s'], 19:57:58 INFO - 'tests': ['tp5o']}, 19:57:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'talos_options': ['--xperf_path', 19:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:58 INFO - 'tests': ['tp5n']}, 19:57:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:58 INFO - 'talos_options': ['--e10s', 19:57:58 INFO - '--xperf_path', 19:57:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:58 INFO - 'tests': ['tp5n']}}, 19:57:58 INFO - 'talos.zip': {'path': '', 19:57:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:57:58 INFO - Running post-action listener: _resource_record_post_action 19:57:58 INFO - ##### 19:57:58 INFO - ##### Running create-virtualenv step. 19:57:58 INFO - ##### 19:57:58 INFO - Running pre-action listener: _resource_record_pre_action 19:57:58 INFO - Running main action method: create_virtualenv 19:57:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:57:58 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 19:57:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:57:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:57:58 INFO - Using real prefix '/usr' 19:57:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:57:59 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:01 INFO - Installing pip.................done. 19:58:01 INFO - Return code: 0 19:58:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:01 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:01 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 19:58:01 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 19:58:01 INFO - Using env: {'DISPLAY': ':0', 19:58:01 INFO - 'HOME': '/home/cltbld', 19:58:01 INFO - 'LANG': 'en_US.UTF-8', 19:58:01 INFO - 'LANGUAGE': 'en_US:en', 19:58:01 INFO - 'LOGNAME': 'cltbld', 19:58:01 INFO - 'MAIL': '/var/mail/cltbld', 19:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:01 INFO - 'MOZ_NO_REMOTE': '1', 19:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:01 INFO - 'NO_EM_RESTART': '1', 19:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:01 INFO - 'SHELL': '/bin/bash', 19:58:01 INFO - 'SHLVL': '1', 19:58:01 INFO - 'TERM': 'linux', 19:58:01 INFO - 'TMOUT': '86400', 19:58:01 INFO - 'USER': 'cltbld', 19:58:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:01 INFO - '_': '/tools/buildbot/bin/python'} 19:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:01 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 19:58:01 INFO - Cleaning up... 19:58:01 INFO - Return code: 0 19:58:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:01 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:01 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 19:58:01 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 19:58:01 INFO - Using env: {'DISPLAY': ':0', 19:58:01 INFO - 'HOME': '/home/cltbld', 19:58:01 INFO - 'LANG': 'en_US.UTF-8', 19:58:01 INFO - 'LANGUAGE': 'en_US:en', 19:58:01 INFO - 'LOGNAME': 'cltbld', 19:58:01 INFO - 'MAIL': '/var/mail/cltbld', 19:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:01 INFO - 'MOZ_NO_REMOTE': '1', 19:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:01 INFO - 'NO_EM_RESTART': '1', 19:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:01 INFO - 'SHELL': '/bin/bash', 19:58:01 INFO - 'SHLVL': '1', 19:58:01 INFO - 'TERM': 'linux', 19:58:01 INFO - 'TMOUT': '86400', 19:58:01 INFO - 'USER': 'cltbld', 19:58:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:01 INFO - '_': '/tools/buildbot/bin/python'} 19:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:01 INFO - Downloading/unpacking psutil>=0.7.1 19:58:01 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 19:58:01 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 19:58:01 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 19:58:01 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 19:58:01 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 19:58:01 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 19:58:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:03 INFO - Installing collected packages: psutil 19:58:03 INFO - Running setup.py install for psutil 19:58:03 INFO - building 'psutil._psutil_linux' extension 19:58:03 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 19:58:04 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 19:58:04 INFO - building 'psutil._psutil_posix' extension 19:58:04 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 19:58:04 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 19:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:04 INFO - Successfully installed psutil 19:58:04 INFO - Cleaning up... 19:58:04 INFO - Return code: 0 19:58:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:58:04 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')]} 19:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:04 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')]} 19:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:04 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:04 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 19:58:04 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 19:58:04 INFO - Using env: {'DISPLAY': ':0', 19:58:04 INFO - 'HOME': '/home/cltbld', 19:58:04 INFO - 'LANG': 'en_US.UTF-8', 19:58:04 INFO - 'LANGUAGE': 'en_US:en', 19:58:04 INFO - 'LOGNAME': 'cltbld', 19:58:04 INFO - 'MAIL': '/var/mail/cltbld', 19:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:04 INFO - 'MOZ_NO_REMOTE': '1', 19:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:04 INFO - 'NO_EM_RESTART': '1', 19:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:04 INFO - 'SHELL': '/bin/bash', 19:58:04 INFO - 'SHLVL': '1', 19:58:04 INFO - 'TERM': 'linux', 19:58:04 INFO - 'TMOUT': '86400', 19:58:04 INFO - 'USER': 'cltbld', 19:58:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:04 INFO - '_': '/tools/buildbot/bin/python'} 19:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:58:04 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 19:58:04 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 19:58:04 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 19:58:04 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 19:58:04 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 19:58:04 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 19:58:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:58:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:58:06 INFO - Installing collected packages: mozsystemmonitor 19:58:06 INFO - Running setup.py install for mozsystemmonitor 19:58:06 INFO - Successfully installed mozsystemmonitor 19:58:06 INFO - Cleaning up... 19:58:06 INFO - Return code: 0 19:58:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:58:06 INFO - Using env: {'DISPLAY': ':0', 19:58:06 INFO - 'HOME': '/home/cltbld', 19:58:06 INFO - 'LANG': 'en_US.UTF-8', 19:58:06 INFO - 'LANGUAGE': 'en_US:en', 19:58:06 INFO - 'LOGNAME': 'cltbld', 19:58:06 INFO - 'MAIL': '/var/mail/cltbld', 19:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:06 INFO - 'MOZ_NO_REMOTE': '1', 19:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:06 INFO - 'NO_EM_RESTART': '1', 19:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:06 INFO - 'SHELL': '/bin/bash', 19:58:06 INFO - 'SHLVL': '1', 19:58:06 INFO - 'TERM': 'linux', 19:58:06 INFO - 'TMOUT': '86400', 19:58:06 INFO - 'USER': 'cltbld', 19:58:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:06 INFO - '_': '/tools/buildbot/bin/python'} 19:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:06 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:58:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:09 INFO - Downloading docopt-0.6.1.tar.gz 19:58:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:09 INFO - Running setup.py install for blobuploader 19:58:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:58:09 INFO - Running setup.py install for requests 19:58:09 INFO - Running setup.py install for docopt 19:58:09 INFO - Successfully installed blobuploader requests docopt 19:58:09 INFO - Cleaning up... 19:58:09 INFO - Return code: 0 19:58:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:09 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')]} 19:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:09 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')]} 19:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:09 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:09 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 19:58:09 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 19:58:09 INFO - Using env: {'DISPLAY': ':0', 19:58:09 INFO - 'HOME': '/home/cltbld', 19:58:09 INFO - 'LANG': 'en_US.UTF-8', 19:58:09 INFO - 'LANGUAGE': 'en_US:en', 19:58:09 INFO - 'LOGNAME': 'cltbld', 19:58:09 INFO - 'MAIL': '/var/mail/cltbld', 19:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:09 INFO - 'MOZ_NO_REMOTE': '1', 19:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:09 INFO - 'NO_EM_RESTART': '1', 19:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:09 INFO - 'SHELL': '/bin/bash', 19:58:09 INFO - 'SHLVL': '1', 19:58:09 INFO - 'TERM': 'linux', 19:58:09 INFO - 'TMOUT': '86400', 19:58:09 INFO - 'USER': 'cltbld', 19:58:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:09 INFO - '_': '/tools/buildbot/bin/python'} 19:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:10 INFO - Running setup.py (path:/tmp/pip-42Z3Ke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:10 INFO - Running setup.py (path:/tmp/pip-Mwul2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:10 INFO - Running setup.py (path:/tmp/pip-l679fm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:10 INFO - Running setup.py (path:/tmp/pip-CWGZUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:10 INFO - Running setup.py (path:/tmp/pip-f2SZcj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:10 INFO - Running setup.py (path:/tmp/pip-RLwvWb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:10 INFO - Running setup.py (path:/tmp/pip-e14PBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:10 INFO - Running setup.py (path:/tmp/pip-btXL8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:10 INFO - Running setup.py (path:/tmp/pip-qXpnjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:10 INFO - Running setup.py (path:/tmp/pip-HLbiAb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:10 INFO - Running setup.py (path:/tmp/pip-8hGcM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:10 INFO - Running setup.py (path:/tmp/pip-9OHW4l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:10 INFO - Running setup.py (path:/tmp/pip-1w9sIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:10 INFO - Running setup.py (path:/tmp/pip-YV5AVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:11 INFO - Running setup.py (path:/tmp/pip-UZOqC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:11 INFO - Running setup.py (path:/tmp/pip-xf8iIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:11 INFO - Running setup.py (path:/tmp/pip-SBKi4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:11 INFO - Running setup.py install for manifestparser 19:58:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:58:11 INFO - Running setup.py install for mozcrash 19:58:11 INFO - Running setup.py install for mozdebug 19:58:11 INFO - Running setup.py install for mozdevice 19:58:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:58:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:58:11 INFO - Running setup.py install for mozfile 19:58:11 INFO - Running setup.py install for mozhttpd 19:58:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:58:11 INFO - Running setup.py install for mozinfo 19:58:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:58:11 INFO - Running setup.py install for mozInstall 19:58:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Running setup.py install for mozleak 19:58:12 INFO - Running setup.py install for mozlog 19:58:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Running setup.py install for moznetwork 19:58:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Running setup.py install for mozprocess 19:58:12 INFO - Running setup.py install for mozprofile 19:58:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Running setup.py install for mozrunner 19:58:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Running setup.py install for mozscreenshot 19:58:12 INFO - Running setup.py install for moztest 19:58:12 INFO - Running setup.py install for mozversion 19:58:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:58:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:12 INFO - Cleaning up... 19:58:13 INFO - Return code: 0 19:58:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:13 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:13 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 19:58:13 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 19:58:13 INFO - Using env: {'DISPLAY': ':0', 19:58:13 INFO - 'HOME': '/home/cltbld', 19:58:13 INFO - 'LANG': 'en_US.UTF-8', 19:58:13 INFO - 'LANGUAGE': 'en_US:en', 19:58:13 INFO - 'LOGNAME': 'cltbld', 19:58:13 INFO - 'MAIL': '/var/mail/cltbld', 19:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:13 INFO - 'MOZ_NO_REMOTE': '1', 19:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:13 INFO - 'NO_EM_RESTART': '1', 19:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:13 INFO - 'SHELL': '/bin/bash', 19:58:13 INFO - 'SHLVL': '1', 19:58:13 INFO - 'TERM': 'linux', 19:58:13 INFO - 'TMOUT': '86400', 19:58:13 INFO - 'USER': 'cltbld', 19:58:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:13 INFO - '_': '/tools/buildbot/bin/python'} 19:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:13 INFO - Running setup.py (path:/tmp/pip-KCrC0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:13 INFO - Running setup.py (path:/tmp/pip-TGSYIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:13 INFO - Running setup.py (path:/tmp/pip-Q1lcm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:13 INFO - Running setup.py (path:/tmp/pip-xv6I7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:13 INFO - Running setup.py (path:/tmp/pip-8WfCfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:13 INFO - Running setup.py (path:/tmp/pip-HWkuVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:13 INFO - Running setup.py (path:/tmp/pip-it3h72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:13 INFO - Running setup.py (path:/tmp/pip-siaZpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:13 INFO - Running setup.py (path:/tmp/pip-wtIhjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:13 INFO - Running setup.py (path:/tmp/pip-RfN_Bx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:13 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)) 19:58:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:13 INFO - Running setup.py (path:/tmp/pip-ZyAVSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:14 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)) 19:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:14 INFO - Running setup.py (path:/tmp/pip-mAAp4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:14 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)) 19:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:14 INFO - Running setup.py (path:/tmp/pip-KAyWrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:14 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)) 19:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:14 INFO - Running setup.py (path:/tmp/pip-_qp1d0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:14 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)) 19:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:14 INFO - Running setup.py (path:/tmp/pip-Qk8WWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:14 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)) 19:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:14 INFO - Running setup.py (path:/tmp/pip-19dZuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:14 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)) 19:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:14 INFO - Running setup.py (path:/tmp/pip-L8PtpB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:14 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)) 19:58:14 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)) 19:58:14 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)) 19:58:14 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)) 19:58:14 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)) 19:58:14 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)) 19:58:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:14 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 19:58:14 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 19:58:14 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 19:58:14 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 19:58:14 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 19:58:14 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 19:58:16 INFO - Downloading blessings-1.6.tar.gz 19:58:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:16 INFO - Installing collected packages: blessings 19:58:16 INFO - Running setup.py install for blessings 19:58:16 INFO - Successfully installed blessings 19:58:16 INFO - Cleaning up... 19:58:16 INFO - Return code: 0 19:58:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:58:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:16 INFO - Reading from file tmpfile_stdout 19:58:16 INFO - Current package versions: 19:58:16 INFO - argparse == 1.2.1 19:58:16 INFO - blessings == 1.6 19:58:16 INFO - blobuploader == 1.2.4 19:58:16 INFO - docopt == 0.6.1 19:58:16 INFO - manifestparser == 1.1 19:58:16 INFO - mozInstall == 1.12 19:58:16 INFO - mozcrash == 0.16 19:58:16 INFO - mozdebug == 0.1 19:58:16 INFO - mozdevice == 0.48 19:58:16 INFO - mozfile == 1.2 19:58:16 INFO - mozhttpd == 0.7 19:58:16 INFO - mozinfo == 0.9 19:58:16 INFO - mozleak == 0.1 19:58:16 INFO - mozlog == 3.1 19:58:16 INFO - moznetwork == 0.27 19:58:16 INFO - mozprocess == 0.22 19:58:16 INFO - mozprofile == 0.28 19:58:16 INFO - mozrunner == 6.11 19:58:16 INFO - mozscreenshot == 0.1 19:58:16 INFO - mozsystemmonitor == 0.0 19:58:16 INFO - moztest == 0.7 19:58:16 INFO - mozversion == 1.4 19:58:16 INFO - psutil == 3.1.1 19:58:16 INFO - requests == 1.2.3 19:58:16 INFO - wsgiref == 0.1.2 19:58:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:16 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:16 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 19:58:16 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 19:58:16 INFO - Using env: {'DISPLAY': ':0', 19:58:16 INFO - 'HOME': '/home/cltbld', 19:58:16 INFO - 'LANG': 'en_US.UTF-8', 19:58:16 INFO - 'LANGUAGE': 'en_US:en', 19:58:16 INFO - 'LOGNAME': 'cltbld', 19:58:16 INFO - 'MAIL': '/var/mail/cltbld', 19:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:16 INFO - 'MOZ_NO_REMOTE': '1', 19:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:16 INFO - 'NO_EM_RESTART': '1', 19:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:16 INFO - 'SHELL': '/bin/bash', 19:58:16 INFO - 'SHLVL': '1', 19:58:16 INFO - 'TERM': 'linux', 19:58:16 INFO - 'TMOUT': '86400', 19:58:16 INFO - 'USER': 'cltbld', 19:58:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:16 INFO - '_': '/tools/buildbot/bin/python'} 19:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 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)) 19:58:16 INFO - Cleaning up... 19:58:16 INFO - Return code: 0 19:58:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:16 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 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:16 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 19:58:16 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 19:58:16 INFO - Using env: {'DISPLAY': ':0', 19:58:16 INFO - 'HOME': '/home/cltbld', 19:58:16 INFO - 'LANG': 'en_US.UTF-8', 19:58:16 INFO - 'LANGUAGE': 'en_US:en', 19:58:16 INFO - 'LOGNAME': 'cltbld', 19:58:16 INFO - 'MAIL': '/var/mail/cltbld', 19:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:16 INFO - 'MOZ_NO_REMOTE': '1', 19:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:16 INFO - 'NO_EM_RESTART': '1', 19:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:16 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:16 INFO - 'SHELL': '/bin/bash', 19:58:16 INFO - 'SHLVL': '1', 19:58:16 INFO - 'TERM': 'linux', 19:58:16 INFO - 'TMOUT': '86400', 19:58:16 INFO - 'USER': 'cltbld', 19:58:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:16 INFO - '_': '/tools/buildbot/bin/python'} 19:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:17 INFO - Downloading/unpacking jsonschema 19:58:17 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 19:58:17 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 19:58:17 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 19:58:17 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 19:58:17 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 19:58:17 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 19:58:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:18 INFO - Downloading/unpacking functools32 (from jsonschema) 19:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:19 INFO - warning: no files found matching '*.txt' 19:58:19 INFO - no previously-included directories found matching 'build' 19:58:19 INFO - no previously-included directories found matching 'dist' 19:58:19 INFO - no previously-included directories found matching '.git*' 19:58:19 INFO - Installing collected packages: jsonschema, functools32 19:58:19 INFO - Running setup.py install for functools32 19:58:19 INFO - warning: no files found matching '*.txt' 19:58:19 INFO - no previously-included directories found matching 'build' 19:58:19 INFO - no previously-included directories found matching 'dist' 19:58:19 INFO - no previously-included directories found matching '.git*' 19:58:19 INFO - Successfully installed jsonschema functools32 19:58:19 INFO - Cleaning up... 19:58:19 INFO - Return code: 0 19:58:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:58: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')]} 19:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc11583ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', '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 19:58:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:58:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:58:19 INFO - Using env: {'DISPLAY': ':0', 19:58:19 INFO - 'HOME': '/home/cltbld', 19:58:19 INFO - 'LANG': 'en_US.UTF-8', 19:58:19 INFO - 'LANGUAGE': 'en_US:en', 19:58:19 INFO - 'LOGNAME': 'cltbld', 19:58:19 INFO - 'MAIL': '/var/mail/cltbld', 19:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:19 INFO - 'MOZ_NO_REMOTE': '1', 19:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:19 INFO - 'NO_EM_RESTART': '1', 19:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:19 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:19 INFO - 'SHELL': '/bin/bash', 19:58:19 INFO - 'SHLVL': '1', 19:58:19 INFO - 'TERM': 'linux', 19:58:19 INFO - 'TMOUT': '86400', 19:58:19 INFO - 'USER': 'cltbld', 19:58:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:19 INFO - '_': '/tools/buildbot/bin/python'} 19:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:19 INFO - Downloading/unpacking flake8 19:58:19 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 19:58:19 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 19:58:19 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 19:58:19 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 19:58:19 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 19:58:19 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 19:58:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:58:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:58:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:58:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:21 INFO - no previously-included directories found matching 'docs/_build' 19:58:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:58:22 INFO - Running setup.py install for pep8 19:58:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:22 INFO - no previously-included directories found matching 'docs/_build' 19:58:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:58:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:58:22 INFO - Cleaning up... 19:58:22 INFO - Return code: 0 19:58:22 INFO - Running post-action listener: _resource_record_post_action 19:58:22 INFO - Running post-action listener: _start_resource_monitoring 19:58:22 INFO - Starting resource monitoring. 19:58:22 INFO - ##### 19:58:22 INFO - ##### Running install step. 19:58:22 INFO - ##### 19:58:22 INFO - Running pre-action listener: _resource_record_pre_action 19:58:22 INFO - Running main action method: install 19:58:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:22 INFO - Reading from file tmpfile_stdout 19:58:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:58:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:58:22 INFO - Reading from file tmpfile_stdout 19:58:22 INFO - Output received: 19:58:22 INFO - Usage: mozinstall [options] installer 19:58:22 INFO - Options: 19:58:22 INFO - -h, --help show this help message and exit 19:58:22 INFO - -d DEST, --destination=DEST 19:58:22 INFO - Directory to install application into. [default: 19:58:22 INFO - "/builds/slave/test-pgo"] 19:58:22 INFO - --app=APP Application being installed. [default: firefox] 19:58:22 INFO - mkdir: /builds/slave/test-pgo/build/application 19:58:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:58:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:58:38 INFO - Reading from file tmpfile_stdout 19:58:38 INFO - Output received: 19:58:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:58:38 INFO - Running post-action listener: _resource_record_post_action 19:58:38 INFO - ##### 19:58:38 INFO - ##### Running run-tests step. 19:58:38 INFO - ##### 19:58:38 INFO - Running pre-action listener: _resource_record_pre_action 19:58:38 INFO - Running main action method: run_tests 19:58:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:58:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:58:38 INFO - Python 2.7.3 19:58:38 INFO - Return code: 0 19:58:38 INFO - grabbing minidump binary from tooltool 19:58:38 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')]} 19:58:38 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 0x291e540>, '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 0x291f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291f8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:58:38 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 19:58:38 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 19:58:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:58:38 INFO - Return code: 0 19:58:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:58:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:58:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:58:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:58:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:58:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:58:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:58:39 INFO - Return code: 0 19:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 19:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 19:58:39 INFO - Using env: {'DISPLAY': ':0', 19:58:39 INFO - 'HOME': '/home/cltbld', 19:58:39 INFO - 'LANG': 'en_US.UTF-8', 19:58:39 INFO - 'LANGUAGE': 'en_US:en', 19:58:39 INFO - 'LOGNAME': 'cltbld', 19:58:39 INFO - 'MAIL': '/var/mail/cltbld', 19:58:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:58:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:39 INFO - 'MOZ_NO_REMOTE': '1', 19:58:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:39 INFO - 'NO_EM_RESTART': '1', 19:58:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:58:39 INFO - 'SHELL': '/bin/bash', 19:58:39 INFO - 'SHLVL': '1', 19:58:39 INFO - 'TERM': 'linux', 19:58:39 INFO - 'TMOUT': '86400', 19:58:39 INFO - 'USER': 'cltbld', 19:58:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274', 19:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:39 INFO - '_': '/tools/buildbot/bin/python'} 19:58:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 19:58:40 INFO - mozversion application_buildid: 20160122173011 19:58:40 INFO - mozversion application_changeset: 361fd7db4ba38bc8954e168b142294e077e96591 19:58:40 INFO - mozversion application_display_name: Nightly 19:58:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:58:40 INFO - mozversion application_name: Firefox 19:58:40 INFO - mozversion application_remotingname: firefox 19:58:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:58:40 INFO - mozversion application_vendor: Mozilla 19:58:40 INFO - mozversion application_version: 46.0a1 19:58:40 INFO - mozversion platform_buildid: 20160122173011 19:58:40 INFO - mozversion platform_changeset: 361fd7db4ba38bc8954e168b142294e077e96591 19:58:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:58:40 INFO - mozversion platform_version: 46.0a1 19:58:40 INFO - using testdate: 1453521520 19:58:40 INFO - actual date: 1453521520 19:58:40 INFO - starting webserver on 'localhost:35437' 19:58:40 INFO - SUITE-START | Running 3 tests 19:58:40 INFO - TEST-START | dromaeo_css 19:58:40 INFO - operating with platform_type : linux_ 19:58:40 INFO - Initialising browser for dromaeo_css test... 19:58:40 INFO - TEST-INFO | started process 10573 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj8kCiY/profile http://localhost:35437/getInfo.html) 19:58:43 INFO - PROCESS | 10573 | __metrics Screen width/height:1600/1200 19:58:43 INFO - PROCESS | 10573 | colorDepth:24 19:58:43 INFO - PROCESS | 10573 | Browser inner width/height: 1024/697 19:58:43 INFO - PROCESS | 10573 | __metrics 19:58:43 INFO - PROCESS | 10573 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:58:43 INFO - PROCESS | 10573 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:58:44 INFO - TEST-INFO | 10573: exit 0 19:58:44 INFO - Browser initialized. 19:58:44 INFO - Running cycle 1/1 for dromaeo_css test... 19:58:44 INFO - TEST-INFO | started process 10664 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpj8kCiY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:58:56 INFO - PROCESS | 10664 | RSS: Main: 148275200 19:58:56 INFO - PROCESS | 10664 | 19:59:47 INFO - PROCESS | 10664 | 1453521587836 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:01:56 INFO - PROCESS | 10664 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35437/tests/dromaeo/cssquery-ext.html) 20:01:57 INFO - PROCESS | 10664 | RSS: Main: 244744192 20:01:57 INFO - PROCESS | 10664 | 20:04:59 INFO - PROCESS | 10664 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-ext.html (next: http://localhost:35437/tests/dromaeo/cssquery-jquery.html) 20:05:00 INFO - PROCESS | 10664 | RSS: Main: 235565056 20:05:00 INFO - PROCESS | 10664 | 20:08:02 INFO - PROCESS | 10664 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35437/tests/dromaeo/cssquery-mootools.html) 20:08:02 INFO - PROCESS | 10664 | RSS: Main: 239083520 20:08:02 INFO - PROCESS | 10664 | 20:11:04 INFO - PROCESS | 10664 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35437/tests/dromaeo/cssquery-prototype.html) 20:11:05 INFO - PROCESS | 10664 | RSS: Main: 209879040 20:11:05 INFO - PROCESS | 10664 | 20:14:07 INFO - PROCESS | 10664 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35437/tests/dromaeo/cssquery-yui.html) 20:14:08 INFO - PROCESS | 10664 | RSS: Main: 210423808 20:14:08 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | Cycle 1(1): loaded http://localhost:35437/tests/dromaeo/cssquery-yui.html (next: http://localhost:35437/tests/dromaeo/cssquery-dojo.html) 20:17:11 INFO - PROCESS | 10664 | RSS: Main: 237748224 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | __start_tp_report 20:17:11 INFO - PROCESS | 10664 | _x_x_mozilla_page_load 20:17:11 INFO - PROCESS | 10664 | _x_x_mozilla_page_load_details 20:17:11 INFO - PROCESS | 10664 | |i|pagename|runs| 20:17:11 INFO - PROCESS | 10664 | |0;dojo.html;3085.213270615993;3097.6282846058475;3137.6077990251233;3140.968590314096;3178.2213357727355;4920.286558449023;5030.798768049273;5138.794448222071;5153.149730294502;5185.066687996159;5135.691858488493;5151.896962060757;5179.689218646884;5187.247849061884;5203.583713302936;4477.753723545204;4607.35497030416;4645.535446455345;4704.6236301096005;4818.397700287464;4587.42657167854;4664.3003549467685;4763.523647635226;4770.141374552579;4879.658423910328;4648.628109751228;4694.29585562165;4716.174669432836;4717.95282047182;4731.101090792756;4692.36653051837;4716.811327546894;4718.575328220477;4720.952790472085;4743.1699452596;4616.376789133491;4688.226442636961;4698.694584851974;4715.269133284346;4758.333833263346;4970.502949705036;5044.8234311798915;5048.217526283395;5066.290719299301;5073.086844368012;5506.201600767907;5519.889602207973;5522.696251706155;5527.585431092684;5581;5406.378266499363;5497.422770609109;5528.44715528444;5555.30558680165;5615.073512870372;5187.04039752647;5194.532492075694;5206.245094461282;5208.479152084799;5230.241614965847;5633.746481408347;5643.379228284885;5643.830685079454;5646.435356464321;5647.1529270609735;5320.414754377015;5406.189071639207;5432.185172224119;5446.700431476228;5529.972350138223;5434.483724046209;5438.265834112344;5439.211314359396;5451.727413629303;5451.727413629382;5390.703511306838;5397.568194544506;5403.35159780821;5433.755481003364;5450.400455949843;5357.839264821983;5455.290812194389;5522.116461366162;5549.972250138723;5621.747021384048;4290.034742183047;4333.783310834446;4335.804888780012;4335.913281734348;4368.36658684489;3782.5460944686815;3861.0733423978045;3870.438786376016;3875.6511913927884;3898.7855667938534;5046.520580544842;5179.559737422362;5251.4485978972425;5260.184671375943;5266.92099618506;5431.918521222185;5459.972700136554;5483.561315094783;5486.067368547357;5493.368262649767;5051.87370315745;5098.770555325019;5114.130597798383;5115.38615366151;5118.616103792156;4629.837955671603;4710.317004034464;4733.5266473352385;4782.354382158364;4821.2045012573235;5671.773129074873;5716.57125715573;5725.713714314267;5728.283964504521;5733.856653583611;5370.543503802221;5510.118381059172;5511.476409741068;5526.171074338881;5563.443655634404;5572.108462645957;5628.521575666115;5698.458646428583;5728.026235540052;5764.193012978102;5460.91808622863;5463.235147079492;5478.753456094406;5479.863003424946;5480.342358916955;5349.545288650508;5459.208414779914;5556.416576259596;5563.833085007456;5605.467480589337;5438.075527160313;5460.099083651153;5464.836054918359;5466.180072989084;5507.173923911445;5361.892762144657;5392.784288628411;5394.811181608782;5404.702741349106;5415.214793854948;5215.478452154754;5301.443348448357;5323.281357016753;5325.09473389517;5327.067763141512;5438.782448702008;5458.263134476795;5458.972705136449;5465.480779325958;5471.097268950738;5326.813561525328;5336.412994570672;5341.5459685927135;5351.143816989263;5355.116405793156 20:17:11 INFO - PROCESS | 10664 | |1;ext.html;514.7863636590818;532.5180711456134;556.905326094564;569.1917477182401;569.5842035314221;26929.730702692967;27437.31406714833;34376.4843527347;34712.30575388491;34798;37934.43098353527;38452.80773596128;38479.422808657895;38507.42238866419;38536.80731596345;7301.561906285613;8265.917340826605;8468.195521425454;8472.110428405022;8475.660973561051;7303.8539229215385;9737.659181928633;10047.346922450053;10047.799044019115;10047.849282260735;9673.75815604612;9771.657991970282;9773.755656108618;9774.853377199348;9780.315377923549;9765.414075155513;9863.704088877344;9864.210863131004;9866.506674666238;9870.25973052024;9687.70936871895;9826.557804898797;9827.55775990075;9834.918159002504;9835.950820245853;37459.81270093659;37744;37779.81110094432;37902.43146352807;37918.67284645052;3110.3623757129735;3280.6719328067243;3295.8352082396023;3655.689266412358;3711.628837116267;28913.42173156525;28968.130956071353;29028.27429314263;29238.707612923812;29270.121896343142;3425.3491836550975;3457.757956943015;3576.0702217423395;3908.413737939332;4095.8361665533344;258248;263070;263168;264096;265447;52033.21950170751;57161;57388.713056435285;57448.425515744304;57503.712481437324;49182;63217;63455;63900;63957.36042639514;14890.106593604418;15065.09609423438;15180.620484487976;15194.696106077816;15246.23768811555;11628.94185529067;11673.941630291794;11724.355160466086;11744.29534227932;11756.94121529387;19200.80799192018;19207.615847683246;19217.61564768697;19251.614967700567;20003.59992800165;7685.692572297045;7818.374530037583;7946.32456241226;7980.4812687175145;7992.484678585752;1038.2420832791954;1038.2472707287307;1040.0327695243495;1085.2077983072402;1135.2217214378852;27936.720298326974;28013.57979630307;28485.85757071243;28530.572041419397;28754.856225718737;1032.7573020340214;1041.1410586266209;1046.4715318763976;1068.076114161245;1080.8919108089128;13474.663133421744;16121.596960075858;16226.918865405834;16539.83460165407;17176.742348864776;381386;383800;384532;384616;387132;52042.21936670953;52415.47584524106;52494.21258681123;52644.73677631664;52707.47292527026;1184.3722826901756;1227.1042139238407;1256.7800634888858;1337.7993301004733;1350.8986825987893;26115.738842611332;26454.470910582066;27130.864345678146;28596.42807143887;28622.713772862837;40164.59835401725;40242;40262.79868600638;40386.1922761549;40526.59473405228;291084;297217;322902;329487;329873;31286.68713312929;31290;31386.52920206153;31451;31568.843115688247;40226.1954760909;40795.1840963185;41030.69177736414;41303.7934810324;41407;33435.83282083574;34395.31209375848;34401.35581696439;34700.305993879476;34922.65077349194;35116.82441587776;35551.82224088863;35884.129269658886;36002.45996310005;36078.8196059018;34566.82716586401;34824.303513930085;35192.82403588068;35485;35544.46683299804;30928.381432371676;32163.839180803945;32595.511067334483;32612.83693581517;32652.51021234636;24192.63711044371;24628.6305705411;24766.504669906863;25121.49757004813;25185.622215667147 20:17:11 INFO - PROCESS | 10664 | |2;jquery.html;361.8046255022288;363.5746176972941;363.68722898307465;365.64532403568535;370.82756518219026;13394.621104569773;13420.73158536831;15277.312520936557;16407.75388369174;17545.122743862805;14270.500532481365;14792.408303667868;15066;15106.848931510682;15308.846911530882;5068.087744206042;5233.842984710464;5247.501487358695;5250.737463126848;5251;3986.2027594481074;4143.19207754488;5190.662606930538;5283.498067683564;5623.240862483553;5691;5735.512481439062;5803.970980145094;5809.186713860063;5814.273215848019;5640.717964101778;5749.821286636229;5761.135829625548;5768.192453056555;5773.134029895528;4963.726995015273;4999.600031997432;5031.597472202215;5184.818531351422;5237.973810130963;11740.823887641693;12156.392180390945;12162.695932601668;19145.234190632356;19299.614007719767;2074.408793493862;2105.189502041725;2149.161826887515;2164.8701077935375;2546.1597672767944;9251.907480925172;9430.952845235799;11196.888031119748;11605.709857253552;12094.637160885188;1733.3759846455391;1761.5331937036694;1769.9292028318853;1780.8842425242317;1785.7321401789707;54403;54567.9999999996;54578.454215457736;54962.72518637421;56412.43587564113;10170.338927969658;10207.438590877424;10208;10237.795244095076;10268.229882758673;13227.669308267177;13386.665333366549;13406.664833379244;13416.396262168031;13441.529546466023;7100.715971361191;7102.467314951399;7108.8933665995055;7151.213366529678;7195.676194571257;6705;6985;7102.28977102296;7174.166204349357;7178.60517671533;4344.304911214191;4403.64604019384;4476.37330773692;4508.1659892919915;4519.480259770103;1720.971090880035;1772.4682595221382;1773.3527262549335;1782.9197686104158;1783.8126996665164;432.0882937002921;861.6294993153004;886.1537231943479;974.9714051675409;1002.3134153105001;10420.166386689047;10755.83866242007;10898.673039808818;11068.446577671084;11144.944275278573;458.2553350804942;460.31413194340195;469.24217388916657;470.1396444506545;483.59136529632406;5625.887482250414;5937.287525496968;5959.374265702126;6076.240469941257;6087.8478038048515;261203;397061.01469493046;406794;508677;513470;62277;62563.37436625666;63294.68352658207;63713.681431593475;65762.34237657658;1136.181948996721;1145.238416453066;1155.225998580936;1166.6091859227083;1177.6584790410684;13786.793198101836;14232.004581331323;15223.619409514851;15419.768703469681;15541.300641471387;32782.67217327796;33010.83494582512;33032.50451243281;33520.49719254165;33520.49719254165;38520;39444.2111157781;39940.8002959995;40279;41420;6975.546589471668;7021.473389495911;7042.084529011196;7283.490155689263;7394.519356241827;10397.32417392867;10636.84044739345;10666.573337066431;10689.679309620724;10811.13510919109;3081.6147981502313;7085.433165346863;7175.605341706257;7295.306945840137;7320.487565870551;7081.964590177016;7527.924720752722;7576.469647124648;7991.200879911962;8084.151164127918;7617.695292188472;7657.234276572298;7663.463557550918;7721.6139193041245;7758.45690801661;9584.089511496397;9592;9723.222142228746;9739.513024348897;9809.362391444532;9634.325597208128;9834.311598188344;9900.653477128266;9966.202703783825;9997.550110245202 20:17:11 INFO - PROCESS | 10664 | |3;mootools.html;1279.3795009420423;1459.1026518691006;1460.5691321060285;1593.9521814345567;1739.8347157020087;7161.104861892263;7334.523255988363;7784.610769461533;7848.960755196216;7853.8821917671285;7956.2441568050945;7968.043834739825;8044.477108987911;8047.31597814185;8051.235132662402;2025.8581899267058;2065.8967051647433;2350.165691179632;2376.013954209001;2383;2343.4610039690883;2389.581823180945;2390.9282721518293;2400.0039983406864;2401.8438801477937;2315.305408377488;2321.361625552978;2381.630847218675;2385.5705972924866;2387.808975281982;2340.8361414700976;2361.315218586608;2370.845895016827;2381.666566680666;2384.1297926256966;2343.800776933963;2348.213348528228;2362.3739708977137;2365.9881700591386;2367.6685264063044;8109.094362824731;8143.674253029872;8158.102608713037;8170.101288858221;8172.141925097898;4875.853724388274;5000.224965130375;5031.245313203049;5033.496650334974;5033.924491132636;3178.698023687746;3179.0780673604627;3224.25842056326;3254.4792833146585;3274.9345013099605;974.9268804839594;1014.624588902111;1023.5291765787747;1031.1338475680388;1059.4702648675661;11253.493592788343;11316.94341528287;11325.150613704005;11336.263142895768;11349.432528373549;4486.573775491323;4547.454305483363;4616.746078965622;4618.399608050999;4625.352450656911;9695.806083878282;9728.416295022322;9752.707418777307;9760.560774765152;9760.755981100387;5029.949700503022;5050.621203409759;5050.9494905051215;5051.166557518042;5057.367829021372;4510.2783554631105;4546.477155127137;4582.931256031162;4587.128445595326;4589.311603259538;3544.8050357230086;3614.710823134143;3791.1280405506886;3816.14136819219;3846.9038274042814;1205.5659962413524;1213.4721396192685;1223.2599277437023;1223.3088305107585;1232.778099942001;1282.58316047285;1285.479380850757;1306.8366454193226;1309.7380523895258;1309.8100775387516;7219.061522002106;7234.131904171533;7287.979682844406;7291.5625062495355;7295.781126566211;1094.9945250273697;1114.6679717737227;1118.496676495564;1118.6588090632272;1119.8600174978128;5795.478406943311;5876.9118463223085;5880.0297950838485;5882.470577648032;5882.970585147047;9300.581473833694;9429;9445.0554944505;9519.666811661558;9823.263255255884;9472.857907131398;9480.478573678514;9492.335536512377;9507.33448658601;9517.857232141523;7318.487705860645;7514.39884809214;7578.014858068415;7587.810304742426;7598.658060387406;7449.180590134973;7490.4007679386605;7591.58246296459;7593.620318984139;7602.353799927068;8791.868121978048;8803.911960880308;9037.728868133967;9057.36598438103;9060.320475964198;9080.954595226982;9142.725718228463;9326.440413575207;9339.719808405758;9342.906570934203;7278.563286202845;7398.556086634819;7398.704051838082;7407;7413.184549699637;6815.863682726417;6866.279040700654;6998.930010699828;7524.924750752422;7835.138134805281;6889.517733758589;7042.683079261343;7119.537230080028;7184.317489838457;7340.302671246223;6952.721891124298;7116.50184487081;7118.074650295428;7136.7145314186855;7198.100237470317;7334.596597187206;7358.153812311439;7407.555546667218;7408.925910741039;7409.407247420301;6694.096296999843;6767.289434609295;6774.966125169342;6789.1174147360525;6792.830179245559;6657.933420665731;6690.19717633887;6698.7320507179165;6709.194896612243;6711.865762684816 20:17:11 INFO - PROCESS | 10664 | |4;prototype.html;342.7069855273741;346.6723945871151;350.58980992239077;355.30537798603734;358.44262172322027;5751.166080918264;5885.9705701471485;5927.614705044174;5936.257967754031;5950.523958083354;5697.8005769798065;5857.297124345085;5869.060950247961;5881.735321910513;5905.789313190797;4599.471060828006;4610.561996610317;4611.169989401907;4611.44662640482;4616.169089563878;4349.391085248052;4451.221036318631;4472.597466228039;4607.608353289975;4622.86131416058;4570.360149579062;4574.885627859314;4578.542145785412;4588.678792484528;4593.311003349508;4579.404677391951;4584.541545845422;4590.081983603292;4591.793369298356;4598.126355992385;4059.9594004059877;4063.6545893599077;4067.0645751477327;4069.97965010176;4072.816723247461;5527.806526771584;5562.694051827148;5591.384947655754;5606.6636001839615;5618.325800903917;5294.549963253128;5324.813631522917;5325.920111198335;5328.46715328468;5332;5977.252843394575;6221.3156552779155;6227.314995350508;6239.37606239377;6240.843978900519;4361.781910904442;4375.628071613916;4459.799309031101;4482.193205223059;4506.369108324837;6476.514261430364;6504.804855854285;6511.967440162816;6516.543841931067;6524.771632992823;4598.655100867381;4602.424696912886;4603.470600880874;4604.424446944132;4606.262997920384;4430.357598148251;4555.703879247838;4570.314452832102;4663.556962088596;4674.649401294849;5219.817306394258;5226.503482169188;5233.241180028875;5262.447443018428;5270.5256526912;6314.305426403092;6371.840703982438;6404.231492220963;6406.199225096863;6416.03759436079;1586.3813112885753;1615.579949213213;1615.7010952973737;1618.1909045477262;1621.9513414597582;1085.478970094359;1090.5910283643634;1092.431935393591;1105.6351404036648;1117.608836907076;5956.642601443928;5984.940150598438;5988.9101663475085;5990.550708696778;5994.37059108796;6465.3857883501;6511.0558968949235;6517.152770139852;6522.673866306665;6531.640759758164;5958.64248145104;5962.642241465526;5977.491913187341;5978.252718410199;5985.6408615483215;3411.710004649583;3513.332466831294;3514.61339252682;3527.8059706716376;3531.1172206948263;6812;6823.249442561314;6827.69275382609;6837.555558888656;6843.110395648534;6707.960266158753;6719.0593316935665;6745.08941292929;6788.1175447191545;6810;6679.365460281266;6821.69302381394;6864.24493305736;6866.279040700754;6870.3473170048765;6306.747730090745;6414.069959855888;6453.645049522133;6565.376289252514;6570.08018877348;6465.418112369909;6469.77355792545;6470.450011749054;6472.902906456501;6482.2869484357625;6817.761378351734;6822.8635427292165;6835.7949261522235;6837.213720422215;6837.521373504006;4463.241248987615;4507.2788353863225;4552.066826300666;4564.132814765184;4576.771161441981;6529.118568993125;6529.347065293433;6548.214214294315;6578.671066446755;6581.111549940697;6352.745890164341;6377.23473183221;6378.138951241523;6380.521460890359;6382.585131966407;6230.345813689679;6332.416895776056;6386.93613063882;6400.23197216337;6403.0715546246465;6194.287656919512;6262.655553944577;6264.655443950626;6274.341194174728;6283.057541368831;6415.775447859302;6429.5499315049365;6440.484761218998;6463;6489.610623362613;6063.878722425438;6257.4681152102585;6259.593126446766;6270.467010304175;6272.655003974825 20:17:11 INFO - PROCESS | 10664 | |5;yui.html;759.2786852490134;832.396512528417;833.3916241143961;849.6643825688851;864.3949235535123;13200.471981120756;13344.065915385927;13408.329583520821;13412.329383530834;13416.463341466355;12608;12618.873811261885;12619.179753316028;12626.30555319457;12636.684082897933;659.7921654678761;667.6961982298067;668.0980676087268;795.1253621016893;803.2890891560982;788.2984144111745;788.3811208201563;788.8501184774904;791.3669064748207;791.8455901099288;839.8320335932807;845.1252953193446;845.2899564365931;845.8562044452427;853.6414705823569;688.5249178067168;695.0130814243786;841.3269384492412;841.8232171244016;852.1563651984521;515.2606010375124;620.9348018458043;624.8594066335083;627.3444250757968;630.4200135875006;12547;12624.873751262461;12638.936805316007;12675.809862852064;12815.679608009781;12393.194442361308;13002.739945201138;13137.408816603276;13358.998075144404;13393.19640821554;10536.367817930948;10601.84097238542;10641.414722190277;10645.30805497648;10865.619703310425;4138.503379594468;4215.180839542665;4251.808668609889;4276.23027854986;4291.163223171483;48928.26607600889;51405.742971285275;51451.485485145415;51518;51996.22005669918;8859.29125669945;9305.767355816024;9317.673881414117;9320.114589114159;9573.617055317709;17971.191296391695;18045.278188872562;18050.819491804912;18087.366942157223;18096.095195240185;6454.903176452263;6652.168478940132;6703.095082163943;6946.756863509854;7056.259092795182;3995.9800200998807;4106.096658735073;4140.275451795924;4178.05993651426;4360.258756011485;3091.2426455518544;3133.81197128173;3133.827639479805;3137.8901738439044;3139.340738444952;566.8526183192399;581.3953488372131;590.447931184344;597.310106826616;599.3826358850391;570.5236127833306;619.5941658213877;660.9372109649576;662.1987395251703;672.8676034039242;8329.791755206168;8613.138686131462;9445.669401570913;9711.514424278757;9714.368566043184;567.7728908436659;613.187526527353;616.0881894795638;660.6102399584269;682.8395327098128;3780.4707340972286;3816.1604447022164;4026.9194616107516;4073.572274911151;4189.141226048653;51293;55086.724566377714;55151.44848551463;55199.724001379735;55223.44776552264;50400.747996259786;50477.24284135741;51122;51614.74192629013;51633.225501617504;44751.328730068424;45145;45185.096298073855;45324.77337613357;46135.53864461379;8275.50346979159;8330.833383332421;8507.447015943944;8508;8519.914800851911;33281.33437331191;33633.327333453686;33911.152221194665;33917.49123763195;34430.65569344274;41599.79200104101;42150.1569968605;45683.31475027944;45780.31329529993;46104.7694761524;10275.229357798344;10287.125594324567;10366;10913.890861091288;11590.536378544764;11892.345920974429;11983.34091624969;11990.40047997614;12140.696482588006;12248.632541023784;11539.24994875364;11552.768944620891;11581.247218930743;11709.707257318636;12003.219790713576;10825.783484330112;10895.56417743313;11253.493592788507;11359.772804544029;11369.31784092957;10780.514876830719;11007.61473348429;11164.609238676607;11286.20996530235;11532.25040372373;9165.495897725423;9461.290403219924;9514.904850951401;9626.807463850544;9991.650292239738;9477.383970041925;9486.288528360263;9581.856272156063;9965.202783777426;10062.647807326708 20:17:11 INFO - PROCESS | 10664 | __end_tp_report 20:17:11 INFO - PROCESS | 10664 | __start_cc_report 20:17:11 INFO - PROCESS | 10664 | _x_x_mozilla_cycle_collect,764 20:17:11 INFO - PROCESS | 10664 | __end_cc_report 20:17:11 INFO - PROCESS | 10664 | __startTimestamp1453522631329__endTimestamp 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | ------- Summary: start ------- 20:17:11 INFO - PROCESS | 10664 | Number of tests: 6 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | [#0] dojo.html Cycles:165 Average:5125.43 Median:5336.41 stddev:551.13 (10.3%) stddev-sans-first:529.07 20:17:11 INFO - PROCESS | 10664 | Values: 3085.2 3097.6 3137.6 3141.0 3178.2 4920.3 5030.8 5138.8 5153.1 5185.1 5135.7 5151.9 5179.7 5187.2 5203.6 4477.8 4607.4 4645.5 4704.6 4818.4 4587.4 4664.3 4763.5 4770.1 4879.7 4648.6 4694.3 4716.2 4718.0 4731.1 4692.4 4716.8 4718.6 4721.0 4743.2 4616.4 4688.2 4698.7 4715.3 4758.3 4970.5 5044.8 5048.2 5066.3 5073.1 5506.2 5519.9 5522.7 5527.6 5581.0 5406.4 5497.4 5528.4 5555.3 5615.1 5187.0 5194.5 5206.2 5208.5 5230.2 5633.7 5643.4 5643.8 5646.4 5647.2 5320.4 5406.2 5432.2 5446.7 5530.0 5434.5 5438.3 5439.2 5451.7 5451.7 5390.7 5397.6 5403.4 5433.8 5450.4 5357.8 5455.3 5522.1 5550.0 5621.7 4290.0 4333.8 4335.8 4335.9 4368.4 3782.5 3861.1 3870.4 3875.7 3898.8 5046.5 5179.6 5251.4 5260.2 5266.9 5431.9 5460.0 5483.6 5486.1 5493.4 5051.9 5098.8 5114.1 5115.4 5118.6 4629.8 4710.3 4733.5 4782.4 4821.2 5671.8 5716.6 5725.7 5728.3 5733.9 5370.5 5510.1 5511.5 5526.2 5563.4 5572.1 5628.5 5698.5 5728.0 5764.2 5460.9 5463.2 5478.8 5479.9 5480.3 5349.5 5459.2 5556.4 5563.8 5605.5 5438.1 5460.1 5464.8 5466.2 5507.2 5361.9 5392.8 5394.8 5404.7 5415.2 5215.5 5301.4 5323.3 5325.1 5327.1 5438.8 5458.3 5459.0 5465.5 5471.1 5326.8 5336.4 5341.5 5351.1 5355.1 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | [#1] ext.html Cycles:180 Average:47951.53 Median:34706.31 stddev:85229.34 (245.6%) stddev-sans-first:85394.01 20:17:11 INFO - PROCESS | 10664 | Values: 514.8 532.5 556.9 569.2 569.6 26929.7 27437.3 34376.5 34712.3 34798.0 37934.4 38452.8 38479.4 38507.4 38536.8 7301.6 8265.9 8468.2 8472.1 8475.7 7303.9 9737.7 10047.3 10047.8 10047.8 9673.8 9771.7 9773.8 9774.9 9780.3 9765.4 9863.7 9864.2 9866.5 9870.3 9687.7 9826.6 9827.6 9834.9 9836.0 37459.8 37744.0 37779.8 37902.4 37918.7 3110.4 3280.7 3295.8 3655.7 3711.6 28913.4 28968.1 29028.3 29238.7 29270.1 3425.3 3457.8 3576.1 3908.4 4095.8 258248.0 263070.0 263168.0 264096.0 265447.0 52033.2 57161.0 57388.7 57448.4 57503.7 49182.0 63217.0 63455.0 63900.0 63957.4 14890.1 15065.1 15180.6 15194.7 15246.2 11628.9 11673.9 11724.4 11744.3 11756.9 19200.8 19207.6 19217.6 19251.6 20003.6 7685.7 7818.4 7946.3 7980.5 7992.5 1038.2 1038.2 1040.0 1085.2 1135.2 27936.7 28013.6 28485.9 28530.6 28754.9 1032.8 1041.1 1046.5 1068.1 1080.9 13474.7 16121.6 16226.9 16539.8 17176.7 381386.0 383800.0 384532.0 384616.0 387132.0 52042.2 52415.5 52494.2 52644.7 52707.5 1184.4 1227.1 1256.8 1337.8 1350.9 26115.7 26454.5 27130.9 28596.4 28622.7 40164.6 40242.0 40262.8 40386.2 40526.6 291084.0 297217.0 322902.0 329487.0 329873.0 31286.7 31290.0 31386.5 31451.0 31568.8 40226.2 40795.2 41030.7 41303.8 41407.0 33435.8 34395.3 34401.4 34700.3 34922.7 35116.8 35551.8 35884.1 36002.5 36078.8 34566.8 34824.3 35192.8 35485.0 35544.5 30928.4 32163.8 32595.5 32612.8 32652.5 24192.6 24628.6 24766.5 25121.5 25185.6 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | [#2] jquery.html Cycles:180 Average:23136.02 Median:2488.87 stddev:70015.51 (2813.1%) stddev-sans-first:70191.04 20:17:11 INFO - PROCESS | 10664 | Values: 361.8 363.6 363.7 365.6 370.8 13394.6 13420.7 15277.3 16407.8 17545.1 14270.5 14792.4 15066.0 15106.8 15308.8 5068.1 5233.8 5247.5 5250.7 5251.0 3986.2 4143.2 5190.7 5283.5 5623.2 5691.0 5735.5 5804.0 5809.2 5814.3 5640.7 5749.8 5761.1 5768.2 5773.1 4963.7 4999.6 5031.6 5184.8 5238.0 11740.8 12156.4 12162.7 19145.2 19299.6 2074.4 2105.2 2149.2 2164.9 2546.2 9251.9 9431.0 11196.9 11605.7 12094.6 1733.4 1761.5 1769.9 1780.9 1785.7 54403.0 54568.0 54578.5 54962.7 56412.4 10170.3 10207.4 10208.0 10237.8 10268.2 13227.7 13386.7 13406.7 13416.4 13441.5 7100.7 7102.5 7108.9 7151.2 7195.7 6705.0 6985.0 7102.3 7174.2 7178.6 4344.3 4403.6 4476.4 4508.2 4519.5 1721.0 1772.5 1773.4 1782.9 1783.8 432.1 861.6 886.2 975.0 1002.3 10420.2 10755.8 10898.7 11068.4 11144.9 458.3 460.3 469.2 470.1 483.6 5625.9 5937.3 5959.4 6076.2 6087.8 261203.0 397061.0 406794.0 508677.0 513470.0 62277.0 62563.4 63294.7 63713.7 65762.3 1136.2 1145.2 1155.2 1166.6 1177.7 13786.8 14232.0 15223.6 15419.8 15541.3 32782.7 33010.8 33032.5 33520.5 33520.5 38520.0 39444.2 39940.8 40279.0 41420.0 6975.5 7021.5 7042.1 7283.5 7394.5 10397.3 10636.8 10666.6 10689.7 10811.1 3081.6 7085.4 7175.6 7295.3 7320.5 7082.0 7527.9 7576.5 7991.2 8084.2 7617.7 7657.2 7663.5 7721.6 7758.5 9584.1 9592.0 9723.2 9739.5 9809.4 9634.3 9834.3 9900.7 9966.2 9997.6 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | [#3] mootools.html Cycles:180 Average:5662.55 Median:6692.15 stddev:2934.60 (43.9%) stddev-sans-first:2924.33 20:17:11 INFO - PROCESS | 10664 | Values: 1279.4 1459.1 1460.6 1594.0 1739.8 7161.1 7334.5 7784.6 7849.0 7853.9 7956.2 7968.0 8044.5 8047.3 8051.2 2025.9 2065.9 2350.2 2376.0 2383.0 2343.5 2389.6 2390.9 2400.0 2401.8 2315.3 2321.4 2381.6 2385.6 2387.8 2340.8 2361.3 2370.8 2381.7 2384.1 2343.8 2348.2 2362.4 2366.0 2367.7 8109.1 8143.7 8158.1 8170.1 8172.1 4875.9 5000.2 5031.2 5033.5 5033.9 3178.7 3179.1 3224.3 3254.5 3274.9 974.9 1014.6 1023.5 1031.1 1059.5 11253.5 11316.9 11325.2 11336.3 11349.4 4486.6 4547.5 4616.7 4618.4 4625.4 9695.8 9728.4 9752.7 9760.6 9760.8 5029.9 5050.6 5050.9 5051.2 5057.4 4510.3 4546.5 4582.9 4587.1 4589.3 3544.8 3614.7 3791.1 3816.1 3846.9 1205.6 1213.5 1223.3 1223.3 1232.8 1282.6 1285.5 1306.8 1309.7 1309.8 7219.1 7234.1 7288.0 7291.6 7295.8 1095.0 1114.7 1118.5 1118.7 1119.9 5795.5 5876.9 5880.0 5882.5 5883.0 9300.6 9429.0 9445.1 9519.7 9823.3 9472.9 9480.5 9492.3 9507.3 9517.9 7318.5 7514.4 7578.0 7587.8 7598.7 7449.2 7490.4 7591.6 7593.6 7602.4 8791.9 8803.9 9037.7 9057.4 9060.3 9081.0 9142.7 9326.4 9339.7 9342.9 7278.6 7398.6 7398.7 7407.0 7413.2 6815.9 6866.3 6998.9 7524.9 7835.1 6889.5 7042.7 7119.5 7184.3 7340.3 6952.7 7116.5 7118.1 7136.7 7198.1 7334.6 7358.2 7407.6 7408.9 7409.4 6694.1 6767.3 6775.0 6789.1 6792.8 6657.9 6690.2 6698.7 6709.2 6711.9 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | [#4] prototype.html Cycles:180 Average:5301.30 Median:5957.64 stddev:1588.45 (26.7%) stddev-sans-first:1548.69 20:17:11 INFO - PROCESS | 10664 | Values: 342.7 346.7 350.6 355.3 358.4 5751.2 5886.0 5927.6 5936.3 5950.5 5697.8 5857.3 5869.1 5881.7 5905.8 4599.5 4610.6 4611.2 4611.4 4616.2 4349.4 4451.2 4472.6 4607.6 4622.9 4570.4 4574.9 4578.5 4588.7 4593.3 4579.4 4584.5 4590.1 4591.8 4598.1 4060.0 4063.7 4067.1 4070.0 4072.8 5527.8 5562.7 5591.4 5606.7 5618.3 5294.5 5324.8 5325.9 5328.5 5332.0 5977.3 6221.3 6227.3 6239.4 6240.8 4361.8 4375.6 4459.8 4482.2 4506.4 6476.5 6504.8 6512.0 6516.5 6524.8 4598.7 4602.4 4603.5 4604.4 4606.3 4430.4 4555.7 4570.3 4663.6 4674.6 5219.8 5226.5 5233.2 5262.4 5270.5 6314.3 6371.8 6404.2 6406.2 6416.0 1586.4 1615.6 1615.7 1618.2 1622.0 1085.5 1090.6 1092.4 1105.6 1117.6 5956.6 5984.9 5988.9 5990.6 5994.4 6465.4 6511.1 6517.2 6522.7 6531.6 5958.6 5962.6 5977.5 5978.3 5985.6 3411.7 3513.3 3514.6 3527.8 3531.1 6812.0 6823.2 6827.7 6837.6 6843.1 6708.0 6719.1 6745.1 6788.1 6810.0 6679.4 6821.7 6864.2 6866.3 6870.3 6306.7 6414.1 6453.6 6565.4 6570.1 6465.4 6469.8 6470.5 6472.9 6482.3 6817.8 6822.9 6835.8 6837.2 6837.5 4463.2 4507.3 4552.1 4564.1 4576.8 6529.1 6529.3 6548.2 6578.7 6581.1 6352.7 6377.2 6378.1 6380.5 6382.6 6230.3 6332.4 6386.9 6400.2 6403.1 6194.3 6262.7 6264.7 6274.3 6283.1 6415.8 6429.5 6440.5 6463.0 6489.6 6063.9 6257.5 6259.6 6270.5 6272.7 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - PROCESS | 10664 | [#5] yui.html Cycles:180 Average:13662.07 Median:47531.90 stddev:15774.53 (33.2%) stddev-sans-first:15789.02 20:17:11 INFO - PROCESS | 10664 | Values: 759.3 832.4 833.4 849.7 864.4 13200.5 13344.1 13408.3 13412.3 13416.5 12608.0 12618.9 12619.2 12626.3 12636.7 659.8 667.7 668.1 795.1 803.3 788.3 788.4 788.9 791.4 791.8 839.8 845.1 845.3 845.9 853.6 688.5 695.0 841.3 841.8 852.2 515.3 620.9 624.9 627.3 630.4 12547.0 12624.9 12638.9 12675.8 12815.7 12393.2 13002.7 13137.4 13359.0 13393.2 10536.4 10601.8 10641.4 10645.3 10865.6 4138.5 4215.2 4251.8 4276.2 4291.2 48928.3 51405.7 51451.5 51518.0 51996.2 8859.3 9305.8 9317.7 9320.1 9573.6 17971.2 18045.3 18050.8 18087.4 18096.1 6454.9 6652.2 6703.1 6946.8 7056.3 3996.0 4106.1 4140.3 4178.1 4360.3 3091.2 3133.8 3133.8 3137.9 3139.3 566.9 581.4 590.4 597.3 599.4 570.5 619.6 660.9 662.2 672.9 8329.8 8613.1 9445.7 9711.5 9714.4 567.8 613.2 616.1 660.6 682.8 3780.5 3816.2 4026.9 4073.6 4189.1 51293.0 55086.7 55151.4 55199.7 55223.4 50400.7 50477.2 51122.0 51614.7 51633.2 44751.3 45145.0 45185.1 45324.8 46135.5 8275.5 8330.8 8507.4 8508.0 8519.9 33281.3 33633.3 33911.2 33917.5 34430.7 41599.8 42150.2 45683.3 45780.3 46104.8 10275.2 10287.1 10366.0 10913.9 11590.5 11892.3 11983.3 11990.4 12140.7 12248.6 11539.2 11552.8 11581.2 11709.7 12003.2 10825.8 10895.6 11253.5 11359.8 11369.3 10780.5 11007.6 11164.6 11286.2 11532.3 9165.5 9461.3 9514.9 9626.8 9991.7 9477.4 9486.3 9581.9 9965.2 10062.6 20:17:11 INFO - PROCESS | 10664 | -------- Summary: end -------- 20:17:11 INFO - PROCESS | 10664 | 20:17:11 INFO - TEST-INFO | 10664: exit 0 20:17:11 INFO - TEST-OK | dromaeo_css | took 1111845ms 20:17:11 INFO - TEST-START | kraken 20:17:11 INFO - operating with platform_type : linux_ 20:17:11 INFO - Initialising browser for kraken test... 20:17:11 INFO - TEST-INFO | started process 10863 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq8jYN4/profile http://localhost:35437/getInfo.html) 20:17:15 INFO - PROCESS | 10863 | __metrics Screen width/height:1600/1200 20:17:15 INFO - PROCESS | 10863 | colorDepth:24 20:17:15 INFO - PROCESS | 10863 | Browser inner width/height: 1024/697 20:17:15 INFO - PROCESS | 10863 | __metrics 20:17:15 INFO - PROCESS | 10863 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:17:15 INFO - PROCESS | 10863 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:16 INFO - TEST-INFO | 10863: exit 0 20:17:16 INFO - Browser initialized. 20:17:16 INFO - Running cycle 1/1 for kraken test... 20:17:16 INFO - TEST-INFO | started process 10945 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq8jYN4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:28 INFO - PROCESS | 10945 | RSS: Main: 148127744 20:17:28 INFO - PROCESS | 10945 | 20:17:30 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-beat-detection) 20:17:31 INFO - PROCESS | 10945 | RSS: Main: 186855424 20:17:31 INFO - PROCESS | 10945 | 20:17:33 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-dft) 20:17:34 INFO - PROCESS | 10945 | RSS: Main: 178581504 20:17:34 INFO - PROCESS | 10945 | 20:17:37 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-fft) 20:17:38 INFO - PROCESS | 10945 | RSS: Main: 163819520 20:17:38 INFO - PROCESS | 10945 | 20:17:40 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35437/tests/kraken/driver.html?testName=audio-oscillator) 20:17:40 INFO - PROCESS | 10945 | RSS: Main: 165228544 20:17:40 INFO - PROCESS | 10945 | 20:17:42 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:17:43 INFO - PROCESS | 10945 | RSS: Main: 166825984 20:17:43 INFO - PROCESS | 10945 | 20:17:46 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-darkroom) 20:17:46 INFO - PROCESS | 10945 | RSS: Main: 168112128 20:17:46 INFO - PROCESS | 10945 | 20:17:50 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35437/tests/kraken/driver.html?testName=imaging-desaturate) 20:17:50 INFO - PROCESS | 10945 | RSS: Main: 167862272 20:17:50 INFO - PROCESS | 10945 | 20:17:53 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35437/tests/kraken/driver.html?testName=json-parse-financial) 20:17:54 INFO - PROCESS | 10945 | RSS: Main: 167968768 20:17:54 INFO - PROCESS | 10945 | 20:17:55 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:17:56 INFO - PROCESS | 10945 | RSS: Main: 181264384 20:17:56 INFO - PROCESS | 10945 | 20:17:58 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:17:58 INFO - PROCESS | 10945 | RSS: Main: 179036160 20:17:58 INFO - PROCESS | 10945 | 20:18:00 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:01 INFO - PROCESS | 10945 | RSS: Main: 183828480 20:18:01 INFO - PROCESS | 10945 | 20:18:03 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:04 INFO - PROCESS | 10945 | RSS: Main: 190300160 20:18:04 INFO - PROCESS | 10945 | 20:18:06 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:07 INFO - PROCESS | 10945 | RSS: Main: 189362176 20:18:07 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | Cycle 1(1): loaded http://localhost:35437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35437/tests/kraken/driver.html?testName=ai-astar) 20:18:09 INFO - PROCESS | 10945 | RSS: Main: 249634816 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | __start_tp_report 20:18:09 INFO - PROCESS | 10945 | _x_x_mozilla_page_load 20:18:09 INFO - PROCESS | 10945 | _x_x_mozilla_page_load_details 20:18:09 INFO - PROCESS | 10945 | |i|pagename|runs| 20:18:09 INFO - PROCESS | 10945 | |0;ai-astar;111;111;106;110;109;110;112;110;105;111 20:18:09 INFO - PROCESS | 10945 | |1;audio-beat-detection;151;122;151;172;132;153;151;129;163;124 20:18:09 INFO - PROCESS | 10945 | |2;audio-dft;162;160;162;159;160;161;161;161;162;163 20:18:09 INFO - PROCESS | 10945 | |3;audio-fft;72;74;99;97;73;74;76;110;92;73 20:18:09 INFO - PROCESS | 10945 | |4;audio-oscillator;96;96;137;94;95;95;139;96;96;147 20:18:09 INFO - PROCESS | 10945 | |5;imaging-gaussian-blur;109;109;110;110;110;109;109;109;109;109 20:18:09 INFO - PROCESS | 10945 | |6;imaging-darkroom;146;145;146;146;146;146;145;146;145;146 20:18:09 INFO - PROCESS | 10945 | |7;imaging-desaturate;95;95;96;96;96;96;96;97;96;96 20:18:09 INFO - PROCESS | 10945 | |8;json-parse-financial;56;56;55;56;56;56;56;57;55;54 20:18:09 INFO - PROCESS | 10945 | |9;json-stringify-tinderbox;66;67;67;67;66;68;66;67;67;68 20:18:09 INFO - PROCESS | 10945 | |10;stanford-crypto-aes;85;84;85;86;87;87;87;87;85;87 20:18:09 INFO - PROCESS | 10945 | |11;stanford-crypto-ccm;115;121;116;121;114;115;121;116;130;117 20:18:09 INFO - PROCESS | 10945 | |12;stanford-crypto-pbkdf2;143;136;142;144;132;132;145;144;141;140 20:18:09 INFO - PROCESS | 10945 | |13;stanford-crypto-sha256-iterative;68;68;68;67;67;64;66;66;69;66 20:18:09 INFO - PROCESS | 10945 | __end_tp_report 20:18:09 INFO - PROCESS | 10945 | __start_cc_report 20:18:09 INFO - PROCESS | 10945 | _x_x_mozilla_cycle_collect,934 20:18:09 INFO - PROCESS | 10945 | __end_cc_report 20:18:09 INFO - PROCESS | 10945 | __startTimestamp1453522689324__endTimestamp 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | ------- Summary: start ------- 20:18:09 INFO - PROCESS | 10945 | Number of tests: 14 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.27 (2.1%) stddev-sans-first:2.35 20:18:09 INFO - PROCESS | 10945 | Values: 111.0 111.0 106.0 110.0 109.0 110.0 112.0 110.0 105.0 111.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:151.00 stddev:17.06 (11.3%) stddev-sans-first:17.95 20:18:09 INFO - PROCESS | 10945 | Values: 151.0 122.0 151.0 172.0 132.0 153.0 151.0 129.0 163.0 124.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 20:18:09 INFO - PROCESS | 10945 | Values: 162.0 160.0 162.0 159.0 160.0 161.0 161.0 161.0 162.0 163.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.00 stddev:14.08 (18.8%) stddev-sans-first:14.25 20:18:09 INFO - PROCESS | 10945 | Values: 72.0 74.0 99.0 97.0 73.0 74.0 76.0 110.0 92.0 73.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.50 stddev:22.16 (23.2%) stddev-sans-first:23.00 20:18:09 INFO - PROCESS | 10945 | Values: 96.0 96.0 137.0 94.0 95.0 95.0 139.0 96.0 96.0 147.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:18:09 INFO - PROCESS | 10945 | Values: 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:18:09 INFO - PROCESS | 10945 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 20:18:09 INFO - PROCESS | 10945 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 20:18:09 INFO - PROCESS | 10945 | Values: 56.0 56.0 55.0 56.0 56.0 56.0 56.0 57.0 55.0 54.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 20:18:09 INFO - PROCESS | 10945 | Values: 66.0 67.0 67.0 67.0 66.0 68.0 66.0 67.0 67.0 68.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:87.00 stddev:1.15 (1.3%) stddev-sans-first:1.17 20:18:09 INFO - PROCESS | 10945 | Values: 85.0 84.0 85.0 86.0 87.0 87.0 87.0 87.0 85.0 87.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:119.00 stddev:4.84 (4.1%) stddev-sans-first:4.95 20:18:09 INFO - PROCESS | 10945 | Values: 115.0 121.0 116.0 121.0 114.0 115.0 121.0 116.0 130.0 117.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:142.50 stddev:4.89 (3.4%) stddev-sans-first:5.05 20:18:09 INFO - PROCESS | 10945 | Values: 143.0 136.0 142.0 144.0 132.0 132.0 145.0 144.0 141.0 140.0 20:18:09 INFO - PROCESS | 10945 | 20:18:09 INFO - PROCESS | 10945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.45 (2.1%) stddev-sans-first:1.48 20:18:09 INFO - PROCESS | 10945 | Values: 68.0 68.0 68.0 67.0 67.0 64.0 66.0 66.0 69.0 66.0 20:18:09 INFO - PROCESS | 10945 | -------- Summary: end -------- 20:18:09 INFO - PROCESS | 10945 | 20:18:10 INFO - TEST-INFO | 10945: exit 0 20:18:10 INFO - TEST-OK | kraken | took 58267ms 20:18:10 INFO - TEST-START | v8_7 20:18:10 INFO - operating with platform_type : linux_ 20:18:10 INFO - Initialising browser for v8_7 test... 20:18:10 INFO - TEST-INFO | started process 11193 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMT5gHm/profile http://localhost:35437/getInfo.html) 20:18:13 INFO - PROCESS | 11193 | __metrics Screen width/height:1600/1200 20:18:13 INFO - PROCESS | 11193 | colorDepth:24 20:18:13 INFO - PROCESS | 11193 | Browser inner width/height: 1024/697 20:18:13 INFO - PROCESS | 11193 | __metrics 20:18:13 INFO - PROCESS | 11193 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:18:14 INFO - PROCESS | 11193 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:18:14 INFO - PROCESS | 11193 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:18:14 INFO - TEST-INFO | 11193: exit 0 20:18:14 INFO - Browser initialized. 20:18:14 INFO - Running cycle 1/1 for v8_7 test... 20:18:14 INFO - TEST-INFO | started process 11279 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMT5gHm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:26 INFO - PROCESS | 11279 | RSS: Main: 145780736 20:18:26 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | Cycle 1(1): loaded http://localhost:35437/tests/v8_7/run.html (next: http://localhost:35437/tests/v8_7/run.html) 20:18:49 INFO - PROCESS | 11279 | RSS: Main: 573698048 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | __start_tp_report 20:18:49 INFO - PROCESS | 11279 | _x_x_mozilla_page_load 20:18:49 INFO - PROCESS | 11279 | _x_x_mozilla_page_load_details 20:18:49 INFO - PROCESS | 11279 | |i|pagename|runs| 20:18:49 INFO - PROCESS | 11279 | |0;Richards;167.897918065816 20:18:49 INFO - PROCESS | 11279 | |1;DeltaBlue;191.0219675262655 20:18:49 INFO - PROCESS | 11279 | |2;Encrypt;281.45229383619477 20:18:49 INFO - PROCESS | 11279 | |3;Decrypt;5181.347150259067 20:18:49 INFO - PROCESS | 11279 | |4;RayTrace;1990.0596421471173 20:18:49 INFO - PROCESS | 11279 | |5;Earley;802.5682182985554 20:18:49 INFO - PROCESS | 11279 | |6;Boyer;12341.463414634147 20:18:49 INFO - PROCESS | 11279 | |7;RegExp;43916.666666666664 20:18:49 INFO - PROCESS | 11279 | |8;Splay;578.7037037037037 20:18:49 INFO - PROCESS | 11279 | |9;NavierStokes;4835.748792270531 20:18:49 INFO - PROCESS | 11279 | __end_tp_report 20:18:49 INFO - PROCESS | 11279 | __startTimestamp1453522729491__endTimestamp 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | ------- Summary: start ------- 20:18:49 INFO - PROCESS | 11279 | Number of tests: 10 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 167.9 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#1] DeltaBlue Cycles:1 Average:191.02 Median:191.02 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 191.0 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 281.5 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 5181.3 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 1990.1 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#5] Earley Cycles:1 Average:802.57 Median:802.57 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 802.6 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 12341.5 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#7] RegExp Cycles:1 Average:43916.67 Median:43916.67 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 43916.7 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#8] Splay Cycles:1 Average:578.70 Median:578.70 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 578.7 20:18:49 INFO - PROCESS | 11279 | 20:18:49 INFO - PROCESS | 11279 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:18:49 INFO - PROCESS | 11279 | Values: 4835.7 20:18:49 INFO - PROCESS | 11279 | -------- Summary: end -------- 20:18:49 INFO - PROCESS | 11279 | 20:18:50 INFO - TEST-INFO | 11279: exit 0 20:18:50 INFO - TEST-OK | v8_7 | took 40214ms 20:18:50 INFO - SUITE-END | took 1210s 20:18:50 INFO - Completed test suite (00:20:10) 20:18:50 INFO - Working with test: dromaeo_css 20:18:50 INFO - Generating results file: dromaeo_css 20:18:50 INFO - Working with test: kraken 20:18:50 INFO - Generating results file: kraken 20:18:50 INFO - javascript benchmark 20:18:50 INFO - Working with test: v8_7 20:18:50 INFO - Generating results file: v8_7 20:18:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:18:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:18:50 INFO - process_Request line: dromaeo_css 6779.99 graph.html#tests=[[72,201,35]] 20:18:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:18:50 INFO - process_Request line: kraken 1493.40 graph.html#tests=[[232,201,35]] 20:18:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:18:50 INFO - process_Request line: v8_7 18822.57 graph.html#tests=[[230,201,35]] 20:18:50 INFO - RETURN: dromaeo_css: 6779.99 20:18:50 INFO - RETURN: kraken: 1493.40 20:18:50 INFO - RETURN: v8_7: 18822.57 20:18:50 INFO - javascript benchmark 20:18:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3085.213270615993, 3097.6282846058475, 3137.6077990251233, 3140.968590314096, 3178.2213357727355, 4920.286558449023, 5030.798768049273, 5138.794448222071, 5153.149730294502, 5185.066687996159, 5135.691858488493, 5151.896962060757, 5179.689218646884, 5187.247849061884, 5203.583713302936, 4477.753723545204, 4607.35497030416, 4645.535446455345, 4704.6236301096005, 4818.397700287464, 4587.42657167854, 4664.3003549467685, 4763.523647635226, 4770.141374552579, 4879.658423910328, 4648.628109751228, 4694.29585562165, 4716.174669432836, 4717.95282047182, 4731.101090792756, 4692.36653051837, 4716.811327546894, 4718.575328220477, 4720.952790472085, 4743.1699452596, 4616.376789133491, 4688.226442636961, 4698.694584851974, 4715.269133284346, 4758.333833263346, 4970.502949705036, 5044.8234311798915, 5048.217526283395, 5066.290719299301, 5073.086844368012, 5506.201600767907, 5519.889602207973, 5522.696251706155, 5527.585431092684, 5581.0, 5406.378266499363, 5497.422770609109, 5528.44715528444, 5555.30558680165, 5615.073512870372, 5187.04039752647, 5194.532492075694, 5206.245094461282, 5208.479152084799, 5230.241614965847, 5633.746481408347, 5643.379228284885, 5643.830685079454, 5646.435356464321, 5647.1529270609735, 5320.414754377015, 5406.189071639207, 5432.185172224119, 5446.700431476228, 5529.972350138223, 5434.483724046209, 5438.265834112344, 5439.211314359396, 5451.727413629303, 5451.727413629382, 5390.703511306838, 5397.568194544506, 5403.35159780821, 5433.755481003364, 5450.400455949843, 5357.839264821983, 5455.290812194389, 5522.116461366162, 5549.972250138723, 5621.747021384048, 4290.034742183047, 4333.783310834446, 4335.804888780012, 4335.913281734348, 4368.36658684489, 3782.5460944686815, 3861.0733423978045, 3870.438786376016, 3875.6511913927884, 3898.7855667938534, 5046.520580544842, 5179.559737422362, 5251.4485978972425, 5260.184671375943, 5266.92099618506, 5431.918521222185, 5459.972700136554, 5483.561315094783, 5486.067368547357, 5493.368262649767, 5051.87370315745, 5098.770555325019, 5114.130597798383, 5115.38615366151, 5118.616103792156, 4629.837955671603, 4710.317004034464, 4733.5266473352385, 4782.354382158364, 4821.2045012573235, 5671.773129074873, 5716.57125715573, 5725.713714314267, 5728.283964504521, 5733.856653583611, 5370.543503802221, 5510.118381059172, 5511.476409741068, 5526.171074338881, 5563.443655634404, 5572.108462645957, 5628.521575666115, 5698.458646428583, 5728.026235540052, 5764.193012978102, 5460.91808622863, 5463.235147079492, 5478.753456094406, 5479.863003424946, 5480.342358916955, 5349.545288650508, 5459.208414779914, 5556.416576259596, 5563.833085007456, 5605.467480589337, 5438.075527160313, 5460.099083651153, 5464.836054918359, 5466.180072989084, 5507.173923911445, 5361.892762144657, 5392.784288628411, 5394.811181608782, 5404.702741349106, 5415.214793854948, 5215.478452154754, 5301.443348448357, 5323.281357016753, 5325.09473389517, 5327.067763141512, 5438.782448702008, 5458.263134476795, 5458.972705136449, 5465.480779325958, 5471.097268950738, 5326.813561525328, 5336.412994570672, 5341.5459685927135, 5351.143816989263, 5355.116405793156], "unit": "score", "name": "dojo.html", "value": 5091.022073404197}, {"lowerIsBetter": false, "replicates": [514.7863636590818, 532.5180711456134, 556.905326094564, 569.1917477182401, 569.5842035314221, 26929.730702692967, 27437.31406714833, 34376.4843527347, 34712.30575388491, 34798.0, 37934.43098353527, 38452.80773596128, 38479.422808657895, 38507.42238866419, 38536.80731596345, 7301.561906285613, 8265.917340826605, 8468.195521425454, 8472.110428405022, 8475.660973561051, 7303.8539229215385, 9737.659181928633, 10047.346922450053, 10047.799044019115, 10047.849282260735, 9673.75815604612, 9771.657991970282, 9773.755656108618, 9774.853377199348, 9780.315377923549, 9765.414075155513, 9863.704088877344, 9864.210863131004, 9866.506674666238, 9870.25973052024, 9687.70936871895, 9826.557804898797, 9827.55775990075, 9834.918159002504, 9835.950820245853, 37459.81270093659, 37744.0, 37779.81110094432, 37902.43146352807, 37918.67284645052, 3110.3623757129735, 3280.6719328067243, 3295.8352082396023, 3655.689266412358, 3711.628837116267, 28913.42173156525, 28968.130956071353, 29028.27429314263, 29238.707612923812, 29270.121896343142, 3425.3491836550975, 3457.757956943015, 3576.0702217423395, 3908.413737939332, 4095.8361665533344, 258248.0, 263070.0, 263168.0, 264096.0, 265447.0, 52033.21950170751, 57161.0, 57388.713056435285, 57448.425515744304, 57503.712481437324, 49182.0, 63217.0, 63455.0, 63900.0, 63957.36042639514, 14890.106593604418, 15065.09609423438, 15180.620484487976, 15194.696106077816, 15246.23768811555, 11628.94185529067, 11673.941630291794, 11724.355160466086, 11744.29534227932, 11756.94121529387, 19200.80799192018, 19207.615847683246, 19217.61564768697, 19251.614967700567, 20003.59992800165, 7685.692572297045, 7818.374530037583, 7946.32456241226, 7980.4812687175145, 7992.484678585752, 1038.2420832791954, 1038.2472707287307, 1040.0327695243495, 1085.2077983072402, 1135.2217214378852, 27936.720298326974, 28013.57979630307, 28485.85757071243, 28530.572041419397, 28754.856225718737, 1032.7573020340214, 1041.1410586266209, 1046.4715318763976, 1068.076114161245, 1080.8919108089128, 13474.663133421744, 16121.596960075858, 16226.918865405834, 16539.83460165407, 17176.742348864776, 381386.0, 383800.0, 384532.0, 384616.0, 387132.0, 52042.21936670953, 52415.47584524106, 52494.21258681123, 52644.73677631664, 52707.47292527026, 1184.3722826901756, 1227.1042139238407, 1256.7800634888858, 1337.7993301004733, 1350.8986825987893, 26115.738842611332, 26454.470910582066, 27130.864345678146, 28596.42807143887, 28622.713772862837, 40164.59835401725, 40242.0, 40262.79868600638, 40386.1922761549, 40526.59473405228, 291084.0, 297217.0, 322902.0, 329487.0, 329873.0, 31286.68713312929, 31290.0, 31386.52920206153, 31451.0, 31568.843115688247, 40226.1954760909, 40795.1840963185, 41030.69177736414, 41303.7934810324, 41407.0, 33435.83282083574, 34395.31209375848, 34401.35581696439, 34700.305993879476, 34922.65077349194, 35116.82441587776, 35551.82224088863, 35884.129269658886, 36002.45996310005, 36078.8196059018, 34566.82716586401, 34824.303513930085, 35192.82403588068, 35485.0, 35544.46683299804, 30928.381432371676, 32163.839180803945, 32595.511067334483, 32612.83693581517, 32652.51021234636, 24192.63711044371, 24628.6305705411, 24766.504669906863, 25121.49757004813, 25185.622215667147], "unit": "score", "name": "ext.html", "value": 18377.432445156668}, {"lowerIsBetter": false, "replicates": [361.8046255022288, 363.5746176972941, 363.68722898307465, 365.64532403568535, 370.82756518219026, 13394.621104569773, 13420.73158536831, 15277.312520936557, 16407.75388369174, 17545.122743862805, 14270.500532481365, 14792.408303667868, 15066.0, 15106.848931510682, 15308.846911530882, 5068.087744206042, 5233.842984710464, 5247.501487358695, 5250.737463126848, 5251.0, 3986.2027594481074, 4143.19207754488, 5190.662606930538, 5283.498067683564, 5623.240862483553, 5691.0, 5735.512481439062, 5803.970980145094, 5809.186713860063, 5814.273215848019, 5640.717964101778, 5749.821286636229, 5761.135829625548, 5768.192453056555, 5773.134029895528, 4963.726995015273, 4999.600031997432, 5031.597472202215, 5184.818531351422, 5237.973810130963, 11740.823887641693, 12156.392180390945, 12162.695932601668, 19145.234190632356, 19299.614007719767, 2074.408793493862, 2105.189502041725, 2149.161826887515, 2164.8701077935375, 2546.1597672767944, 9251.907480925172, 9430.952845235799, 11196.888031119748, 11605.709857253552, 12094.637160885188, 1733.3759846455391, 1761.5331937036694, 1769.9292028318853, 1780.8842425242317, 1785.7321401789707, 54403.0, 54567.9999999996, 54578.454215457736, 54962.72518637421, 56412.43587564113, 10170.338927969658, 10207.438590877424, 10208.0, 10237.795244095076, 10268.229882758673, 13227.669308267177, 13386.665333366549, 13406.664833379244, 13416.396262168031, 13441.529546466023, 7100.715971361191, 7102.467314951399, 7108.8933665995055, 7151.213366529678, 7195.676194571257, 6705.0, 6985.0, 7102.28977102296, 7174.166204349357, 7178.60517671533, 4344.304911214191, 4403.64604019384, 4476.37330773692, 4508.1659892919915, 4519.480259770103, 1720.971090880035, 1772.4682595221382, 1773.3527262549335, 1782.9197686104158, 1783.8126996665164, 432.0882937002921, 861.6294993153004, 886.1537231943479, 974.9714051675409, 1002.3134153105001, 10420.166386689047, 10755.83866242007, 10898.673039808818, 11068.446577671084, 11144.944275278573, 458.2553350804942, 460.31413194340195, 469.24217388916657, 470.1396444506545, 483.59136529632406, 5625.887482250414, 5937.287525496968, 5959.374265702126, 6076.240469941257, 6087.8478038048515, 261203.0, 397061.01469493046, 406794.0, 508677.0, 513470.0, 62277.0, 62563.37436625666, 63294.68352658207, 63713.681431593475, 65762.34237657658, 1136.181948996721, 1145.238416453066, 1155.225998580936, 1166.6091859227083, 1177.6584790410684, 13786.793198101836, 14232.004581331323, 15223.619409514851, 15419.768703469681, 15541.300641471387, 32782.67217327796, 33010.83494582512, 33032.50451243281, 33520.49719254165, 33520.49719254165, 38520.0, 39444.2111157781, 39940.8002959995, 40279.0, 41420.0, 6975.546589471668, 7021.473389495911, 7042.084529011196, 7283.490155689263, 7394.519356241827, 10397.32417392867, 10636.84044739345, 10666.573337066431, 10689.679309620724, 10811.13510919109, 3081.6147981502313, 7085.433165346863, 7175.605341706257, 7295.306945840137, 7320.487565870551, 7081.964590177016, 7527.924720752722, 7576.469647124648, 7991.200879911962, 8084.151164127918, 7617.695292188472, 7657.234276572298, 7663.463557550918, 7721.6139193041245, 7758.45690801661, 9584.089511496397, 9592.0, 9723.222142228746, 9739.513024348897, 9809.362391444532, 9634.325597208128, 9834.311598188344, 9900.653477128266, 9966.202703783825, 9997.550110245202], "unit": "score", "name": "jquery.html", "value": 7466.036878969365}, {"lowerIsBetter": false, "replicates": [1279.3795009420423, 1459.1026518691006, 1460.5691321060285, 1593.9521814345567, 1739.8347157020087, 7161.104861892263, 7334.523255988363, 7784.610769461533, 7848.960755196216, 7853.8821917671285, 7956.2441568050945, 7968.043834739825, 8044.477108987911, 8047.31597814185, 8051.235132662402, 2025.8581899267058, 2065.8967051647433, 2350.165691179632, 2376.013954209001, 2383.0, 2343.4610039690883, 2389.581823180945, 2390.9282721518293, 2400.0039983406864, 2401.8438801477937, 2315.305408377488, 2321.361625552978, 2381.630847218675, 2385.5705972924866, 2387.808975281982, 2340.8361414700976, 2361.315218586608, 2370.845895016827, 2381.666566680666, 2384.1297926256966, 2343.800776933963, 2348.213348528228, 2362.3739708977137, 2365.9881700591386, 2367.6685264063044, 8109.094362824731, 8143.674253029872, 8158.102608713037, 8170.101288858221, 8172.141925097898, 4875.853724388274, 5000.224965130375, 5031.245313203049, 5033.496650334974, 5033.924491132636, 3178.698023687746, 3179.0780673604627, 3224.25842056326, 3254.4792833146585, 3274.9345013099605, 974.9268804839594, 1014.624588902111, 1023.5291765787747, 1031.1338475680388, 1059.4702648675661, 11253.493592788343, 11316.94341528287, 11325.150613704005, 11336.263142895768, 11349.432528373549, 4486.573775491323, 4547.454305483363, 4616.746078965622, 4618.399608050999, 4625.352450656911, 9695.806083878282, 9728.416295022322, 9752.707418777307, 9760.560774765152, 9760.755981100387, 5029.949700503022, 5050.621203409759, 5050.9494905051215, 5051.166557518042, 5057.367829021372, 4510.2783554631105, 4546.477155127137, 4582.931256031162, 4587.128445595326, 4589.311603259538, 3544.8050357230086, 3614.710823134143, 3791.1280405506886, 3816.14136819219, 3846.9038274042814, 1205.5659962413524, 1213.4721396192685, 1223.2599277437023, 1223.3088305107585, 1232.778099942001, 1282.58316047285, 1285.479380850757, 1306.8366454193226, 1309.7380523895258, 1309.8100775387516, 7219.061522002106, 7234.131904171533, 7287.979682844406, 7291.5625062495355, 7295.781126566211, 1094.9945250273697, 1114.6679717737227, 1118.496676495564, 1118.6588090632272, 1119.8600174978128, 5795.478406943311, 5876.9118463223085, 5880.0297950838485, 5882.470577648032, 5882.970585147047, 9300.581473833694, 9429.0, 9445.0554944505, 9519.666811661558, 9823.263255255884, 9472.857907131398, 9480.478573678514, 9492.335536512377, 9507.33448658601, 9517.857232141523, 7318.487705860645, 7514.39884809214, 7578.014858068415, 7587.810304742426, 7598.658060387406, 7449.180590134973, 7490.4007679386605, 7591.58246296459, 7593.620318984139, 7602.353799927068, 8791.868121978048, 8803.911960880308, 9037.728868133967, 9057.36598438103, 9060.320475964198, 9080.954595226982, 9142.725718228463, 9326.440413575207, 9339.719808405758, 9342.906570934203, 7278.563286202845, 7398.556086634819, 7398.704051838082, 7407.0, 7413.184549699637, 6815.863682726417, 6866.279040700654, 6998.930010699828, 7524.924750752422, 7835.138134805281, 6889.517733758589, 7042.683079261343, 7119.537230080028, 7184.317489838457, 7340.302671246223, 6952.721891124298, 7116.50184487081, 7118.074650295428, 7136.7145314186855, 7198.100237470317, 7334.596597187206, 7358.153812311439, 7407.555546667218, 7408.925910741039, 7409.407247420301, 6694.096296999843, 6767.289434609295, 6774.966125169342, 6789.1174147360525, 6792.830179245559, 6657.933420665731, 6690.19717633887, 6698.7320507179165, 6709.194896612243, 6711.865762684816], "unit": "score", "name": "mootools.html", "value": 4650.616830958939}, {"lowerIsBetter": false, "replicates": [342.7069855273741, 346.6723945871151, 350.58980992239077, 355.30537798603734, 358.44262172322027, 5751.166080918264, 5885.9705701471485, 5927.614705044174, 5936.257967754031, 5950.523958083354, 5697.8005769798065, 5857.297124345085, 5869.060950247961, 5881.735321910513, 5905.789313190797, 4599.471060828006, 4610.561996610317, 4611.169989401907, 4611.44662640482, 4616.169089563878, 4349.391085248052, 4451.221036318631, 4472.597466228039, 4607.608353289975, 4622.86131416058, 4570.360149579062, 4574.885627859314, 4578.542145785412, 4588.678792484528, 4593.311003349508, 4579.404677391951, 4584.541545845422, 4590.081983603292, 4591.793369298356, 4598.126355992385, 4059.9594004059877, 4063.6545893599077, 4067.0645751477327, 4069.97965010176, 4072.816723247461, 5527.806526771584, 5562.694051827148, 5591.384947655754, 5606.6636001839615, 5618.325800903917, 5294.549963253128, 5324.813631522917, 5325.920111198335, 5328.46715328468, 5332.0, 5977.252843394575, 6221.3156552779155, 6227.314995350508, 6239.37606239377, 6240.843978900519, 4361.781910904442, 4375.628071613916, 4459.799309031101, 4482.193205223059, 4506.369108324837, 6476.514261430364, 6504.804855854285, 6511.967440162816, 6516.543841931067, 6524.771632992823, 4598.655100867381, 4602.424696912886, 4603.470600880874, 4604.424446944132, 4606.262997920384, 4430.357598148251, 4555.703879247838, 4570.314452832102, 4663.556962088596, 4674.649401294849, 5219.817306394258, 5226.503482169188, 5233.241180028875, 5262.447443018428, 5270.5256526912, 6314.305426403092, 6371.840703982438, 6404.231492220963, 6406.199225096863, 6416.03759436079, 1586.3813112885753, 1615.579949213213, 1615.7010952973737, 1618.1909045477262, 1621.9513414597582, 1085.478970094359, 1090.5910283643634, 1092.431935393591, 1105.6351404036648, 1117.608836907076, 5956.642601443928, 5984.940150598438, 5988.9101663475085, 5990.550708696778, 5994.37059108796, 6465.3857883501, 6511.0558968949235, 6517.152770139852, 6522.673866306665, 6531.640759758164, 5958.64248145104, 5962.642241465526, 5977.491913187341, 5978.252718410199, 5985.6408615483215, 3411.710004649583, 3513.332466831294, 3514.61339252682, 3527.8059706716376, 3531.1172206948263, 6812.0, 6823.249442561314, 6827.69275382609, 6837.555558888656, 6843.110395648534, 6707.960266158753, 6719.0593316935665, 6745.08941292929, 6788.1175447191545, 6810.0, 6679.365460281266, 6821.69302381394, 6864.24493305736, 6866.279040700754, 6870.3473170048765, 6306.747730090745, 6414.069959855888, 6453.645049522133, 6565.376289252514, 6570.08018877348, 6465.418112369909, 6469.77355792545, 6470.450011749054, 6472.902906456501, 6482.2869484357625, 6817.761378351734, 6822.8635427292165, 6835.7949261522235, 6837.213720422215, 6837.521373504006, 4463.241248987615, 4507.2788353863225, 4552.066826300666, 4564.132814765184, 4576.771161441981, 6529.118568993125, 6529.347065293433, 6548.214214294315, 6578.671066446755, 6581.111549940697, 6352.745890164341, 6377.23473183221, 6378.138951241523, 6380.521460890359, 6382.585131966407, 6230.345813689679, 6332.416895776056, 6386.93613063882, 6400.23197216337, 6403.0715546246465, 6194.287656919512, 6262.655553944577, 6264.655443950626, 6274.341194174728, 6283.057541368831, 6415.775447859302, 6429.5499315049365, 6440.484761218998, 6463.0, 6489.610623362613, 6063.878722425438, 6257.4681152102585, 6259.593126446766, 6270.467010304175, 6272.655003974825], "unit": "score", "name": "prototype.html", "value": 4791.373978784637}, {"lowerIsBetter": false, "replicates": [759.2786852490134, 832.396512528417, 833.3916241143961, 849.6643825688851, 864.3949235535123, 13200.471981120756, 13344.065915385927, 13408.329583520821, 13412.329383530834, 13416.463341466355, 12608.0, 12618.873811261885, 12619.179753316028, 12626.30555319457, 12636.684082897933, 659.7921654678761, 667.6961982298067, 668.0980676087268, 795.1253621016893, 803.2890891560982, 788.2984144111745, 788.3811208201563, 788.8501184774904, 791.3669064748207, 791.8455901099288, 839.8320335932807, 845.1252953193446, 845.2899564365931, 845.8562044452427, 853.6414705823569, 688.5249178067168, 695.0130814243786, 841.3269384492412, 841.8232171244016, 852.1563651984521, 515.2606010375124, 620.9348018458043, 624.8594066335083, 627.3444250757968, 630.4200135875006, 12547.0, 12624.873751262461, 12638.936805316007, 12675.809862852064, 12815.679608009781, 12393.194442361308, 13002.739945201138, 13137.408816603276, 13358.998075144404, 13393.19640821554, 10536.367817930948, 10601.84097238542, 10641.414722190277, 10645.30805497648, 10865.619703310425, 4138.503379594468, 4215.180839542665, 4251.808668609889, 4276.23027854986, 4291.163223171483, 48928.26607600889, 51405.742971285275, 51451.485485145415, 51518.0, 51996.22005669918, 8859.29125669945, 9305.767355816024, 9317.673881414117, 9320.114589114159, 9573.617055317709, 17971.191296391695, 18045.278188872562, 18050.819491804912, 18087.366942157223, 18096.095195240185, 6454.903176452263, 6652.168478940132, 6703.095082163943, 6946.756863509854, 7056.259092795182, 3995.9800200998807, 4106.096658735073, 4140.275451795924, 4178.05993651426, 4360.258756011485, 3091.2426455518544, 3133.81197128173, 3133.827639479805, 3137.8901738439044, 3139.340738444952, 566.8526183192399, 581.3953488372131, 590.447931184344, 597.310106826616, 599.3826358850391, 570.5236127833306, 619.5941658213877, 660.9372109649576, 662.1987395251703, 672.8676034039242, 8329.791755206168, 8613.138686131462, 9445.669401570913, 9711.514424278757, 9714.368566043184, 567.7728908436659, 613.187526527353, 616.0881894795638, 660.6102399584269, 682.8395327098128, 3780.4707340972286, 3816.1604447022164, 4026.9194616107516, 4073.572274911151, 4189.141226048653, 51293.0, 55086.724566377714, 55151.44848551463, 55199.724001379735, 55223.44776552264, 50400.747996259786, 50477.24284135741, 51122.0, 51614.74192629013, 51633.225501617504, 44751.328730068424, 45145.0, 45185.096298073855, 45324.77337613357, 46135.53864461379, 8275.50346979159, 8330.833383332421, 8507.447015943944, 8508.0, 8519.914800851911, 33281.33437331191, 33633.327333453686, 33911.152221194665, 33917.49123763195, 34430.65569344274, 41599.79200104101, 42150.1569968605, 45683.31475027944, 45780.31329529993, 46104.7694761524, 10275.229357798344, 10287.125594324567, 10366.0, 10913.890861091288, 11590.536378544764, 11892.345920974429, 11983.34091624969, 11990.40047997614, 12140.696482588006, 12248.632541023784, 11539.24994875364, 11552.768944620891, 11581.247218930743, 11709.707257318636, 12003.219790713576, 10825.783484330112, 10895.56417743313, 11253.493592788507, 11359.772804544029, 11369.31784092957, 10780.514876830719, 11007.61473348429, 11164.609238676607, 11286.20996530235, 11532.25040372373, 9165.495897725423, 9461.290403219924, 9514.904850951401, 9626.807463850544, 9991.650292239738, 9477.383970041925, 9486.288528360263, 9581.856272156063, 9965.202783777426, 10062.647807326708], "unit": "score", "name": "yui.html", "value": 6240.030542455907}], "name": "dromaeo_css", "value": 6779.988332581262}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 110.0, 109.0, 110.0, 112.0, 110.0, 105.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [151.0, 122.0, 151.0, 172.0, 132.0, 153.0, 151.0, 129.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 159.0, 160.0, 161.0, 161.0, 161.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 99.0, 97.0, 73.0, 74.0, 76.0, 110.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 94.0, 95.0, 95.0, 139.0, 96.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 57.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 68.0, 66.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 86.0, 87.0, 87.0, 87.0, 87.0, 85.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [115.0, 121.0, 116.0, 121.0, 114.0, 115.0, 121.0, 116.0, 130.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [143.0, 136.0, 142.0, 144.0, 132.0, 132.0, 145.0, 144.0, 141.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 64.0, 66.0, 66.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1493.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [191.0219675262655], "unit": "score", "name": "DeltaBlue", "value": 346.12773000000004}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [802.5682182985554], "unit": "score", "name": "Earley", "value": 830.4128980000002}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [43916.666666666664], "unit": "score", "name": "RegExp", "value": 20.743491461100557}, {"lowerIsBetter": false, "replicates": [578.7037037037037], "unit": "score", "name": "Splay", "value": 140.81644799999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18822.570610128507}]} 20:18:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18822.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1493.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6779.99"}}} 20:18:50 INFO - Return code: 0 20:18:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:18:50 INFO - # TBPL SUCCESS # 20:18:50 INFO - Running post-action listener: _resource_record_post_action 20:18:50 INFO - Running post-run listener: _resource_record_post_run 20:18:51 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 551301120; Read time: 0; Write time: 463240 20:18:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246845440; Read time: 0; Write time: 242680 20:18:51 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 304222208; Read time: 0; Write time: 220512 20:18:51 INFO - Running post-run listener: _upload_blobber_files 20:18:51 INFO - Blob upload gear active. 20:18:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:18:51 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:18:51 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:18:51 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:18:52 INFO - (blobuploader) - INFO - Open directory for files ... 20:18:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:18:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:18:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:52 INFO - (blobuploader) - INFO - Done attempting. 20:18:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:53 INFO - (blobuploader) - INFO - Done attempting. 20:18:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:18:53 INFO - Return code: 0 20:18:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:18:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:18:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/61a3e5e9849db111d45af9f684ab87f8af1e37ffcb5b62640f921e6c9e42376a87d00f161f46324dca592e54f7c6d1b6661355951c1b74a7fdec9067bb67f04b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/541c9ec7d865d3dab7f2a48c2c620e031b82047aaae889d8358d7aeda28acd5fc72da64f87cb441af682de20ccace862d5efb39880b0de22fbc26700d5234a2b"} 20:18:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:18:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:18:53 INFO - Contents: 20:18:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/61a3e5e9849db111d45af9f684ab87f8af1e37ffcb5b62640f921e6c9e42376a87d00f161f46324dca592e54f7c6d1b6661355951c1b74a7fdec9067bb67f04b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/541c9ec7d865d3dab7f2a48c2c620e031b82047aaae889d8358d7aeda28acd5fc72da64f87cb441af682de20ccace862d5efb39880b0de22fbc26700d5234a2b"} 20:18:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:18:53 INFO - Copying logs to upload dir... 20:18:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:18:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.513193 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-22 20:18:53.412290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 20:18:53.416246) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/61a3e5e9849db111d45af9f684ab87f8af1e37ffcb5b62640f921e6c9e42376a87d00f161f46324dca592e54f7c6d1b6661355951c1b74a7fdec9067bb67f04b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/541c9ec7d865d3dab7f2a48c2c620e031b82047aaae889d8358d7aeda28acd5fc72da64f87cb441af682de20ccace862d5efb39880b0de22fbc26700d5234a2b"} build_url:https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/OkYmqofcQE-uKKEe0tFg_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/61a3e5e9849db111d45af9f684ab87f8af1e37ffcb5b62640f921e6c9e42376a87d00f161f46324dca592e54f7c6d1b6661355951c1b74a7fdec9067bb67f04b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/541c9ec7d865d3dab7f2a48c2c620e031b82047aaae889d8358d7aeda28acd5fc72da64f87cb441af682de20ccace862d5efb39880b0de22fbc26700d5234a2b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 20:18:53.445090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 20:18:53.445907) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453517121.666374-49298274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 20:18:53.525265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 20:18:53.525631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 20:18:53.526307) ========= ========= Total master_lag: 0.29 =========