builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1452500724.59 results: success (0) buildid: 20160110234930 builduid: 9a45b6e490914d2d9ef4647ab8295070 revision: 98d1a38f79a104f137008d29de2f05338b1fc349 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.591932) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.592463) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.592823) ========= bash -c pwd in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006454 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.638754) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.639138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.865475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.865808) ========= rm -rf properties in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.951181) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.951481) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.951875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:24.952185) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 00:25:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-01-11 00:25:25 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.461417 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:25.440180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:25.440529) ========= rm -rf scripts in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:25.492353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:25.493160) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 98d1a38f79a104f137008d29de2f05338b1fc349 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 98d1a38f79a104f137008d29de2f05338b1fc349 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 00:25:25,798 truncating revision to first 12 chars 2016-01-11 00:25:25,798 Setting DEBUG logging. 2016-01-11 00:25:25,798 attempt 1/10 2016-01-11 00:25:25,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/98d1a38f79a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 00:25:26,098 unpacking tar archive at: fx-team-98d1a38f79a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602840 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:26.112762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:26.113277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:26.123595) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:26.124098) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 00:25:26.124648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-01-11 00:25:26.125018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:25:26 INFO - MultiFileLogger online at 20160111 00:25:26 in /builds/slave/test 00:25:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 00:25:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:25:26 INFO - {'append_to_log': False, 00:25:26 INFO - 'base_work_dir': '/builds/slave/test', 00:25:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:25:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:25:26 INFO - 'branch': 'Fx-Team-Non-PGO', 00:25:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:25:26 INFO - 'config_files': ('talos/linux_config.py',), 00:25:26 INFO - 'default_actions': ('clobber', 00:25:26 INFO - 'read-buildbot-config', 00:25:26 INFO - 'download-and-extract', 00:25:26 INFO - 'populate-webroot', 00:25:26 INFO - 'create-virtualenv', 00:25:26 INFO - 'install', 00:25:26 INFO - 'run-tests'), 00:25:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:25:26 INFO - 'download_minidump_stackwalk': True, 00:25:26 INFO - 'download_symbols': 'ondemand', 00:25:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:25:26 INFO - 'tooltool.py': '/tools/tooltool.py', 00:25:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:25:26 INFO - '/tools/misc-python/virtualenv.py')}, 00:25:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:25:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:25:26 INFO - 'installer_path': 'installer.exe', 00:25:26 INFO - 'log_level': 'info', 00:25:26 INFO - 'log_name': 'talos', 00:25:26 INFO - 'log_to_console': True, 00:25:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:25:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:25:26 INFO - 'opt_config_files': (), 00:25:26 INFO - 'pip_index': False, 00:25:26 INFO - 'sps_profile': False, 00:25:26 INFO - 'sps_profile_interval': 0, 00:25:26 INFO - 'suite': 'dromaeojs-e10s', 00:25:26 INFO - 'system_bits': '32', 00:25:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:25:26 INFO - 'title': 'talos-linux64-ix-002', 00:25:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:25:26 INFO - 'use_talos_json': True, 00:25:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:25:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:25:26 INFO - 'work_dir': 'build'} 00:25:26 INFO - ##### 00:25:26 INFO - ##### Running clobber step. 00:25:26 INFO - ##### 00:25:26 INFO - Running pre-action listener: _resource_record_pre_action 00:25:26 INFO - Running main action method: clobber 00:25:26 INFO - rmtree: /builds/slave/test/build 00:25:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:25:26 INFO - Running post-action listener: _resource_record_post_action 00:25:26 INFO - ##### 00:25:26 INFO - ##### Running read-buildbot-config step. 00:25:26 INFO - ##### 00:25:26 INFO - Running pre-action listener: _resource_record_pre_action 00:25:26 INFO - Running main action method: read_buildbot_config 00:25:26 INFO - Using buildbot properties: 00:25:26 INFO - { 00:25:26 INFO - "project": "", 00:25:26 INFO - "product": "firefox", 00:25:26 INFO - "script_repo_revision": "production", 00:25:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:25:26 INFO - "repository": "", 00:25:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 00:25:26 INFO - "buildid": "20160110234930", 00:25:26 INFO - "pgo_build": "False", 00:25:26 INFO - "basedir": "/builds/slave/test", 00:25:26 INFO - "buildnumber": 942, 00:25:26 INFO - "slavename": "talos-linux64-ix-002", 00:25:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:25:26 INFO - "platform": "ubuntu64_hw", 00:25:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:25:26 INFO - "branch": "fx-team", 00:25:26 INFO - "repo_path": "integration/fx-team", 00:25:26 INFO - "revision": "98d1a38f79a104f137008d29de2f05338b1fc349", 00:25:26 INFO - "stage_platform": "linux64", 00:25:26 INFO - "builduid": "9a45b6e490914d2d9ef4647ab8295070", 00:25:26 INFO - "slavebuilddir": "test" 00:25:26 INFO - } 00:25:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:25:26 INFO - Running post-action listener: _resource_record_post_action 00:25:26 INFO - ##### 00:25:26 INFO - ##### Running download-and-extract step. 00:25:26 INFO - ##### 00:25:26 INFO - Running pre-action listener: _resource_record_pre_action 00:25:26 INFO - Running main action method: download_and_extract 00:25:26 INFO - mkdir: /builds/slave/test/build/tests 00:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:26 INFO - https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/test_packages.json 00:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/test_packages.json 00:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:25:37 INFO - Downloaded 1302 bytes. 00:25:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:25:37 INFO - Using the following test package requirements: 00:25:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:25:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:25:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'jsshell-linux-x86_64.zip'], 00:25:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:25:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:25:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:25:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:25:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:25:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:25:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:25:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:25:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:25:37 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')]} 00:25:37 INFO - https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:25:51 INFO - Downloaded 22761567 bytes. 00:25:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:25:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:25:52 INFO - Return code: 0 00:25:52 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 00:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:25:52 INFO - https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:25:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:26:00 INFO - Downloaded 22761567 bytes. 00:26:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:26:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:26:02 INFO - Return code: 0 00:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:02 INFO - https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:26:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:26:05 INFO - Downloaded 11132285 bytes. 00:26:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 00:26:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:26:05 INFO - Return code: 0 00:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:05 INFO - https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:26:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:26:09 INFO - Downloaded 54055958 bytes. 00:26:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:09 INFO - mkdir: /builds/slave/test/properties 00:26:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:26:09 INFO - Writing to file /builds/slave/test/properties/build_url 00:26:09 INFO - Contents: 00:26:09 INFO - build_url:https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:09 INFO - Running post-action listener: _resource_record_post_action 00:26:09 INFO - Running post-action listener: set_extra_try_arguments 00:26:09 INFO - ##### 00:26:09 INFO - ##### Running populate-webroot step. 00:26:09 INFO - ##### 00:26:09 INFO - Running pre-action listener: _resource_record_pre_action 00:26:09 INFO - Running main action method: populate_webroot 00:26:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:26:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:26:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:26:09 INFO - '--tppagecycles', 00:26:09 INFO - '7'], 00:26:09 INFO - 'tests': ['tsvgm']}}, 00:26:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:26:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:26:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:26:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:26:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'tests': ['damp', 'tps']}, 00:26:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['damp', 'tps']}, 00:26:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:26:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:26:09 INFO - 'other': {'tests': ['a11yr', 00:26:09 INFO - 'ts_paint', 00:26:09 INFO - 'tpaint', 00:26:09 INFO - 'sessionrestore', 00:26:09 INFO - 'sessionrestore_no_auto_restore']}, 00:26:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['a11yr', 00:26:09 INFO - 'ts_paint', 00:26:09 INFO - 'tpaint', 00:26:09 INFO - 'sessionrestore', 00:26:09 INFO - 'sessionrestore_no_auto_restore']}, 00:26:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['a11yr', 00:26:09 INFO - 'ts_paint', 00:26:09 INFO - 'tpaint', 00:26:09 INFO - 'sessionrestore', 00:26:09 INFO - 'sessionrestore_no_auto_restore']}, 00:26:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['a11yr', 00:26:09 INFO - 'ts_paint', 00:26:09 INFO - 'tpaint', 00:26:09 INFO - 'sessionrestore', 00:26:09 INFO - 'sessionrestore_no_auto_restore']}, 00:26:09 INFO - 'other_l64': {'tests': ['a11yr', 00:26:09 INFO - 'ts_paint', 00:26:09 INFO - 'tpaint', 00:26:09 INFO - 'sessionrestore', 00:26:09 INFO - 'sessionrestore_no_auto_restore']}, 00:26:09 INFO - 'other_nol64': {'tests': ['a11yr', 00:26:09 INFO - 'ts_paint', 00:26:09 INFO - 'tpaint', 00:26:09 INFO - 'sessionrestore', 00:26:09 INFO - 'sessionrestore_no_auto_restore']}, 00:26:09 INFO - 'svgr': {'tests': ['tsvgx', 00:26:09 INFO - 'tsvgr_opacity', 00:26:09 INFO - 'tart', 00:26:09 INFO - 'tscrollx', 00:26:09 INFO - 'cart']}, 00:26:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['tsvgx', 00:26:09 INFO - 'tsvgr_opacity', 00:26:09 INFO - 'tart', 00:26:09 INFO - 'tscrollx', 00:26:09 INFO - 'cart']}, 00:26:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'tests': ['tp5o']}, 00:26:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'talos_options': ['--e10s'], 00:26:09 INFO - 'tests': ['tp5o']}, 00:26:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'talos_options': ['--xperf_path', 00:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:09 INFO - 'tests': ['tp5n']}, 00:26:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:09 INFO - 'talos_options': ['--e10s', 00:26:09 INFO - '--xperf_path', 00:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:09 INFO - 'tests': ['tp5n']}}, 00:26:09 INFO - 'talos.zip': {'path': '', 00:26:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:26:09 INFO - Running post-action listener: _resource_record_post_action 00:26:09 INFO - ##### 00:26:09 INFO - ##### Running create-virtualenv step. 00:26:09 INFO - ##### 00:26:09 INFO - Running pre-action listener: _resource_record_pre_action 00:26:09 INFO - Running main action method: create_virtualenv 00:26:09 INFO - Creating virtualenv /builds/slave/test/build/venv 00:26:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:26:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:26:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:26:09 INFO - Using real prefix '/usr' 00:26:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:26:09 INFO - Installing distribute.............................................................................................................................................................................................done. 00:26:11 INFO - Installing pip.................done. 00:26:11 INFO - Return code: 0 00:26:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:26:11 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')]} 00:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:11 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')]} 00:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:26:11 INFO - Using env: {'DISPLAY': ':0', 00:26:11 INFO - 'HOME': '/home/cltbld', 00:26:11 INFO - 'LANG': 'en_US.UTF-8', 00:26:11 INFO - 'LANGUAGE': 'en_US:en', 00:26:11 INFO - 'LOGNAME': 'cltbld', 00:26:11 INFO - 'MAIL': '/var/mail/cltbld', 00:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:11 INFO - 'MOZ_NO_REMOTE': '1', 00:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:11 INFO - 'NO_EM_RESTART': '1', 00:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:11 INFO - 'PWD': '/builds/slave/test', 00:26:11 INFO - 'SHELL': '/bin/bash', 00:26:11 INFO - 'SHLVL': '1', 00:26:11 INFO - 'TERM': 'linux', 00:26:11 INFO - 'TMOUT': '86400', 00:26:11 INFO - 'USER': 'cltbld', 00:26:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:11 INFO - '_': '/tools/buildbot/bin/python'} 00:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:11 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 00:26:11 INFO - Cleaning up... 00:26:11 INFO - Return code: 0 00:26:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:26:11 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')]} 00:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:11 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')]} 00:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:26:11 INFO - Using env: {'DISPLAY': ':0', 00:26:11 INFO - 'HOME': '/home/cltbld', 00:26:11 INFO - 'LANG': 'en_US.UTF-8', 00:26:11 INFO - 'LANGUAGE': 'en_US:en', 00:26:11 INFO - 'LOGNAME': 'cltbld', 00:26:11 INFO - 'MAIL': '/var/mail/cltbld', 00:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:11 INFO - 'MOZ_NO_REMOTE': '1', 00:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:11 INFO - 'NO_EM_RESTART': '1', 00:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:11 INFO - 'PWD': '/builds/slave/test', 00:26:11 INFO - 'SHELL': '/bin/bash', 00:26:11 INFO - 'SHLVL': '1', 00:26:11 INFO - 'TERM': 'linux', 00:26:11 INFO - 'TMOUT': '86400', 00:26:11 INFO - 'USER': 'cltbld', 00:26:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:11 INFO - '_': '/tools/buildbot/bin/python'} 00:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:12 INFO - Downloading/unpacking psutil>=0.7.1 00:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:26:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:13 INFO - Installing collected packages: psutil 00:26:13 INFO - Running setup.py install for psutil 00:26:14 INFO - building 'psutil._psutil_linux' extension 00:26:14 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 00:26:14 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 00:26:14 INFO - building 'psutil._psutil_posix' extension 00:26:14 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 00:26:14 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 00:26:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:14 INFO - Successfully installed psutil 00:26:14 INFO - Cleaning up... 00:26:14 INFO - Return code: 0 00:26:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:26:14 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')]} 00:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:14 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')]} 00:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:26:14 INFO - Using env: {'DISPLAY': ':0', 00:26:14 INFO - 'HOME': '/home/cltbld', 00:26:14 INFO - 'LANG': 'en_US.UTF-8', 00:26:14 INFO - 'LANGUAGE': 'en_US:en', 00:26:14 INFO - 'LOGNAME': 'cltbld', 00:26:14 INFO - 'MAIL': '/var/mail/cltbld', 00:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:14 INFO - 'MOZ_NO_REMOTE': '1', 00:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:14 INFO - 'NO_EM_RESTART': '1', 00:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:14 INFO - 'PWD': '/builds/slave/test', 00:26:14 INFO - 'SHELL': '/bin/bash', 00:26:14 INFO - 'SHLVL': '1', 00:26:14 INFO - 'TERM': 'linux', 00:26:14 INFO - 'TMOUT': '86400', 00:26:14 INFO - 'USER': 'cltbld', 00:26:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:14 INFO - '_': '/tools/buildbot/bin/python'} 00:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:26:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:26:16 INFO - Installing collected packages: mozsystemmonitor 00:26:16 INFO - Running setup.py install for mozsystemmonitor 00:26:16 INFO - Successfully installed mozsystemmonitor 00:26:16 INFO - Cleaning up... 00:26:16 INFO - Return code: 0 00:26:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:26: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')]} 00:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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')]} 00:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:26:16 INFO - Using env: {'DISPLAY': ':0', 00:26:16 INFO - 'HOME': '/home/cltbld', 00:26:16 INFO - 'LANG': 'en_US.UTF-8', 00:26:16 INFO - 'LANGUAGE': 'en_US:en', 00:26:16 INFO - 'LOGNAME': 'cltbld', 00:26:16 INFO - 'MAIL': '/var/mail/cltbld', 00:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:16 INFO - 'MOZ_NO_REMOTE': '1', 00:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:16 INFO - 'NO_EM_RESTART': '1', 00:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:16 INFO - 'PWD': '/builds/slave/test', 00:26:16 INFO - 'SHELL': '/bin/bash', 00:26:16 INFO - 'SHLVL': '1', 00:26:16 INFO - 'TERM': 'linux', 00:26:16 INFO - 'TMOUT': '86400', 00:26:16 INFO - 'USER': 'cltbld', 00:26:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:16 INFO - '_': '/tools/buildbot/bin/python'} 00:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:16 INFO - Downloading/unpacking blobuploader==1.2.4 00:26:16 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 00:26:16 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 00:26:16 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 00:26:16 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 00:26:16 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 00:26:16 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 00:26:18 INFO - Downloading blobuploader-1.2.4.tar.gz 00:26:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:26:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:26:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:19 INFO - Downloading docopt-0.6.1.tar.gz 00:26:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:26:19 INFO - Installing collected packages: blobuploader, requests, docopt 00:26:19 INFO - Running setup.py install for blobuploader 00:26:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:26:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:26:19 INFO - Running setup.py install for requests 00:26:19 INFO - Running setup.py install for docopt 00:26:19 INFO - Successfully installed blobuploader requests docopt 00:26:19 INFO - Cleaning up... 00:26:19 INFO - Return code: 0 00:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:26: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')]} 00:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26: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')]} 00:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 00:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 00:26:19 INFO - Using env: {'DISPLAY': ':0', 00:26:19 INFO - 'HOME': '/home/cltbld', 00:26:19 INFO - 'LANG': 'en_US.UTF-8', 00:26:19 INFO - 'LANGUAGE': 'en_US:en', 00:26:19 INFO - 'LOGNAME': 'cltbld', 00:26:19 INFO - 'MAIL': '/var/mail/cltbld', 00:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:19 INFO - 'MOZ_NO_REMOTE': '1', 00:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:19 INFO - 'NO_EM_RESTART': '1', 00:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:19 INFO - 'PWD': '/builds/slave/test', 00:26:19 INFO - 'SHELL': '/bin/bash', 00:26:19 INFO - 'SHLVL': '1', 00:26:19 INFO - 'TERM': 'linux', 00:26:19 INFO - 'TMOUT': '86400', 00:26:19 INFO - 'USER': 'cltbld', 00:26:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:19 INFO - '_': '/tools/buildbot/bin/python'} 00:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:26:20 INFO - Running setup.py (path:/tmp/pip-k5qXwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:26:20 INFO - Running setup.py (path:/tmp/pip-s896PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:26:20 INFO - Running setup.py (path:/tmp/pip-VOJInR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:26:20 INFO - Running setup.py (path:/tmp/pip-wbmoWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:26:20 INFO - Running setup.py (path:/tmp/pip-cFVj10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:26:20 INFO - Running setup.py (path:/tmp/pip-cCCikd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:26:20 INFO - Running setup.py (path:/tmp/pip-_BfRtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:26:20 INFO - Running setup.py (path:/tmp/pip-tB5A5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:26:20 INFO - Running setup.py (path:/tmp/pip-H_NMK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:26:20 INFO - Running setup.py (path:/tmp/pip-3n_DtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:26:20 INFO - Running setup.py (path:/tmp/pip-GRxWgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:26:20 INFO - Running setup.py (path:/tmp/pip-GZBC8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:26:20 INFO - Running setup.py (path:/tmp/pip-kiHpDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:26:21 INFO - Running setup.py (path:/tmp/pip-tVymAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:21 INFO - Running setup.py (path:/tmp/pip-2K14zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:26:21 INFO - Running setup.py (path:/tmp/pip-oDgmnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:26:21 INFO - Running setup.py (path:/tmp/pip-HWnimM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:26:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:26:21 INFO - Running setup.py install for manifestparser 00:26:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:26:21 INFO - Running setup.py install for mozcrash 00:26:21 INFO - Running setup.py install for mozdebug 00:26:21 INFO - Running setup.py install for mozdevice 00:26:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:26:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:26:21 INFO - Running setup.py install for mozfile 00:26:21 INFO - Running setup.py install for mozhttpd 00:26:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:26:21 INFO - Running setup.py install for mozinfo 00:26:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:26:21 INFO - Running setup.py install for mozInstall 00:26:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Running setup.py install for mozleak 00:26:22 INFO - Running setup.py install for mozlog 00:26:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Running setup.py install for moznetwork 00:26:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Running setup.py install for mozprocess 00:26:22 INFO - Running setup.py install for mozprofile 00:26:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Running setup.py install for mozrunner 00:26:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:26:22 INFO - Running setup.py install for mozscreenshot 00:26:22 INFO - Running setup.py install for moztest 00:26:22 INFO - Running setup.py install for mozversion 00:26:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:26:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:26:23 INFO - Cleaning up... 00:26:23 INFO - Return code: 0 00:26:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 00:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 00:26:23 INFO - Using env: {'DISPLAY': ':0', 00:26:23 INFO - 'HOME': '/home/cltbld', 00:26:23 INFO - 'LANG': 'en_US.UTF-8', 00:26:23 INFO - 'LANGUAGE': 'en_US:en', 00:26:23 INFO - 'LOGNAME': 'cltbld', 00:26:23 INFO - 'MAIL': '/var/mail/cltbld', 00:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:23 INFO - 'MOZ_NO_REMOTE': '1', 00:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:23 INFO - 'NO_EM_RESTART': '1', 00:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:23 INFO - 'PWD': '/builds/slave/test', 00:26:23 INFO - 'SHELL': '/bin/bash', 00:26:23 INFO - 'SHLVL': '1', 00:26:23 INFO - 'TERM': 'linux', 00:26:23 INFO - 'TMOUT': '86400', 00:26:23 INFO - 'USER': 'cltbld', 00:26:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:23 INFO - '_': '/tools/buildbot/bin/python'} 00:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:26:23 INFO - Running setup.py (path:/tmp/pip-W0n8ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:26:23 INFO - Running setup.py (path:/tmp/pip-qw8NEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:26:23 INFO - Running setup.py (path:/tmp/pip-mh_dVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:26:23 INFO - Running setup.py (path:/tmp/pip-kJuZrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:26:23 INFO - Running setup.py (path:/tmp/pip-2lnHtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:26:23 INFO - Running setup.py (path:/tmp/pip-7eZNvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:26:23 INFO - Running setup.py (path:/tmp/pip-hIxMbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:26:23 INFO - Running setup.py (path:/tmp/pip-2db1EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:26:23 INFO - Running setup.py (path:/tmp/pip-X3Va20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:26:23 INFO - Running setup.py (path:/tmp/pip-0lBX3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:26:24 INFO - Running setup.py (path:/tmp/pip-im5sIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:26:24 INFO - Running setup.py (path:/tmp/pip-L9Rw5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:26:24 INFO - Running setup.py (path:/tmp/pip-WY_qa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:26:24 INFO - Running setup.py (path:/tmp/pip-fAjSht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:24 INFO - Running setup.py (path:/tmp/pip-9F7hoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:26:24 INFO - Running setup.py (path:/tmp/pip-BBPPRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:26:24 INFO - Running setup.py (path:/tmp/pip-jvp0YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:26:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:26:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:26 INFO - Downloading blessings-1.5.1.tar.gz 00:26:26 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:26:26 INFO - Installing collected packages: blessings 00:26:26 INFO - Running setup.py install for blessings 00:26:26 INFO - Successfully installed blessings 00:26:26 INFO - Cleaning up... 00:26:26 INFO - Return code: 0 00:26:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:26:26 INFO - Reading from file tmpfile_stdout 00:26:26 INFO - Current package versions: 00:26:26 INFO - argparse == 1.2.1 00:26:26 INFO - blessings == 1.5.1 00:26:26 INFO - blobuploader == 1.2.4 00:26:26 INFO - docopt == 0.6.1 00:26:26 INFO - manifestparser == 1.1 00:26:26 INFO - mozInstall == 1.12 00:26:26 INFO - mozcrash == 0.16 00:26:26 INFO - mozdebug == 0.1 00:26:26 INFO - mozdevice == 0.47 00:26:26 INFO - mozfile == 1.2 00:26:26 INFO - mozhttpd == 0.7 00:26:26 INFO - mozinfo == 0.9 00:26:26 INFO - mozleak == 0.1 00:26:26 INFO - mozlog == 3.1 00:26:26 INFO - moznetwork == 0.27 00:26:26 INFO - mozprocess == 0.22 00:26:26 INFO - mozprofile == 0.28 00:26:26 INFO - mozrunner == 6.11 00:26:26 INFO - mozscreenshot == 0.1 00:26:26 INFO - mozsystemmonitor == 0.0 00:26:26 INFO - moztest == 0.7 00:26:26 INFO - mozversion == 1.4 00:26:26 INFO - psutil == 3.1.1 00:26:26 INFO - requests == 1.2.3 00:26:26 INFO - wsgiref == 0.1.2 00:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 00:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/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 00:26:26 INFO - Using env: {'DISPLAY': ':0', 00:26:26 INFO - 'HOME': '/home/cltbld', 00:26:26 INFO - 'LANG': 'en_US.UTF-8', 00:26:26 INFO - 'LANGUAGE': 'en_US:en', 00:26:26 INFO - 'LOGNAME': 'cltbld', 00:26:26 INFO - 'MAIL': '/var/mail/cltbld', 00:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:26 INFO - 'MOZ_NO_REMOTE': '1', 00:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:26 INFO - 'NO_EM_RESTART': '1', 00:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:26 INFO - 'PWD': '/builds/slave/test', 00:26:26 INFO - 'SHELL': '/bin/bash', 00:26:26 INFO - 'SHLVL': '1', 00:26:26 INFO - 'TERM': 'linux', 00:26:26 INFO - 'TMOUT': '86400', 00:26:26 INFO - 'USER': 'cltbld', 00:26:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:26 INFO - '_': '/tools/buildbot/bin/python'} 00:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:26:26 INFO - Cleaning up... 00:26:26 INFO - Return code: 0 00:26:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:26:26 INFO - Using env: {'DISPLAY': ':0', 00:26:26 INFO - 'HOME': '/home/cltbld', 00:26:26 INFO - 'LANG': 'en_US.UTF-8', 00:26:26 INFO - 'LANGUAGE': 'en_US:en', 00:26:26 INFO - 'LOGNAME': 'cltbld', 00:26:26 INFO - 'MAIL': '/var/mail/cltbld', 00:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:26 INFO - 'MOZ_NO_REMOTE': '1', 00:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:26 INFO - 'NO_EM_RESTART': '1', 00:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:26 INFO - 'PWD': '/builds/slave/test', 00:26:26 INFO - 'SHELL': '/bin/bash', 00:26:26 INFO - 'SHLVL': '1', 00:26:26 INFO - 'TERM': 'linux', 00:26:26 INFO - 'TMOUT': '86400', 00:26:26 INFO - 'USER': 'cltbld', 00:26:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:26 INFO - '_': '/tools/buildbot/bin/python'} 00:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:27 INFO - Downloading/unpacking jsonschema 00:26:27 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 00:26:27 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 00:26:27 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 00:26:27 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 00:26:27 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 00:26:27 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 00:26:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:26:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:26:28 INFO - Downloading/unpacking functools32 (from jsonschema) 00:26:28 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 00:26:28 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 00:26:28 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 00:26:28 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 00:26:28 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 00:26:28 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 00:26:29 INFO - Downloading functools32-3.2.3-2.tar.gz 00:26:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:26:29 INFO - warning: no files found matching '*.txt' 00:26:29 INFO - no previously-included directories found matching 'build' 00:26:29 INFO - no previously-included directories found matching 'dist' 00:26:29 INFO - no previously-included directories found matching '.git*' 00:26:29 INFO - Installing collected packages: jsonschema, functools32 00:26:29 INFO - Running setup.py install for functools32 00:26:29 INFO - warning: no files found matching '*.txt' 00:26:29 INFO - no previously-included directories found matching 'build' 00:26:29 INFO - no previously-included directories found matching 'dist' 00:26:29 INFO - no previously-included directories found matching '.git*' 00:26:29 INFO - Successfully installed jsonschema functools32 00:26:29 INFO - Cleaning up... 00:26:29 INFO - Return code: 0 00:26:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:26:29 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')]} 00:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:29 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')]} 00:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2552c22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd67dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 00:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:26:29 INFO - Using env: {'DISPLAY': ':0', 00:26:29 INFO - 'HOME': '/home/cltbld', 00:26:29 INFO - 'LANG': 'en_US.UTF-8', 00:26:29 INFO - 'LANGUAGE': 'en_US:en', 00:26:29 INFO - 'LOGNAME': 'cltbld', 00:26:29 INFO - 'MAIL': '/var/mail/cltbld', 00:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:29 INFO - 'MOZ_NO_REMOTE': '1', 00:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:29 INFO - 'NO_EM_RESTART': '1', 00:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:29 INFO - 'PWD': '/builds/slave/test', 00:26:29 INFO - 'SHELL': '/bin/bash', 00:26:29 INFO - 'SHLVL': '1', 00:26:29 INFO - 'TERM': 'linux', 00:26:29 INFO - 'TMOUT': '86400', 00:26:29 INFO - 'USER': 'cltbld', 00:26:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:29 INFO - '_': '/tools/buildbot/bin/python'} 00:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:29 INFO - Downloading/unpacking flake8 00:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:26:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 00:26:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:26:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 00:26:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 00:26:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:26:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:26:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:26:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:26:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:26:31 INFO - no previously-included directories found matching 'docs/_build' 00:26:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:26:32 INFO - Running setup.py install for pep8 00:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:26:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:26:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:26:32 INFO - no previously-included directories found matching 'docs/_build' 00:26:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:26:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:26:32 INFO - Cleaning up... 00:26:32 INFO - Return code: 0 00:26:32 INFO - Running post-action listener: _resource_record_post_action 00:26:32 INFO - Running post-action listener: _start_resource_monitoring 00:26:32 INFO - Starting resource monitoring. 00:26:32 INFO - ##### 00:26:32 INFO - ##### Running install step. 00:26:32 INFO - ##### 00:26:32 INFO - Running pre-action listener: _resource_record_pre_action 00:26:32 INFO - Running main action method: install 00:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:26:32 INFO - Reading from file tmpfile_stdout 00:26:32 INFO - Detecting whether we're running mozinstall >=1.0... 00:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:26:32 INFO - Reading from file tmpfile_stdout 00:26:32 INFO - Output received: 00:26:32 INFO - Usage: mozinstall [options] installer 00:26:32 INFO - Options: 00:26:32 INFO - -h, --help show this help message and exit 00:26:32 INFO - -d DEST, --destination=DEST 00:26:32 INFO - Directory to install application into. [default: 00:26:32 INFO - "/builds/slave/test"] 00:26:32 INFO - --app=APP Application being installed. [default: firefox] 00:26:32 INFO - mkdir: /builds/slave/test/build/application 00:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:26:48 INFO - Reading from file tmpfile_stdout 00:26:48 INFO - Output received: 00:26:48 INFO - /builds/slave/test/build/application/firefox/firefox 00:26:48 INFO - Running post-action listener: _resource_record_post_action 00:26:48 INFO - ##### 00:26:48 INFO - ##### Running run-tests step. 00:26:48 INFO - ##### 00:26:48 INFO - Running pre-action listener: _resource_record_pre_action 00:26:48 INFO - Running main action method: run_tests 00:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:26:48 INFO - Python 2.7.3 00:26:48 INFO - Return code: 0 00:26:48 INFO - grabbing minidump binary from tooltool 00:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:48 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/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 0xdfa3d0>, '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 0xd65ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd66360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:26:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:26:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:26:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:26:48 INFO - Return code: 0 00:26:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:26:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:26:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:26:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:26:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:26:49 INFO - Return code: 0 00:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:26:49 INFO - Using env: {'DISPLAY': ':0', 00:26:49 INFO - 'HOME': '/home/cltbld', 00:26:49 INFO - 'LANG': 'en_US.UTF-8', 00:26:49 INFO - 'LANGUAGE': 'en_US:en', 00:26:49 INFO - 'LOGNAME': 'cltbld', 00:26:49 INFO - 'MAIL': '/var/mail/cltbld', 00:26:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:26:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:49 INFO - 'MOZ_NO_REMOTE': '1', 00:26:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:49 INFO - 'NO_EM_RESTART': '1', 00:26:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:49 INFO - 'PWD': '/builds/slave/test', 00:26:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:26:49 INFO - 'SHELL': '/bin/bash', 00:26:49 INFO - 'SHLVL': '1', 00:26:49 INFO - 'TERM': 'linux', 00:26:49 INFO - 'TMOUT': '86400', 00:26:49 INFO - 'USER': 'cltbld', 00:26:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272', 00:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:49 INFO - '_': '/tools/buildbot/bin/python'} 00:26:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:26:49 INFO - mozversion application_buildid: 20160110234930 00:26:49 INFO - mozversion application_changeset: 98d1a38f79a104f137008d29de2f05338b1fc349 00:26:49 INFO - mozversion application_display_name: Nightly 00:26:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:26:49 INFO - mozversion application_name: Firefox 00:26:49 INFO - mozversion application_remotingname: firefox 00:26:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:26:49 INFO - mozversion application_vendor: Mozilla 00:26:49 INFO - mozversion application_version: 46.0a1 00:26:49 INFO - mozversion platform_buildid: 20160110234930 00:26:49 INFO - mozversion platform_changeset: 98d1a38f79a104f137008d29de2f05338b1fc349 00:26:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:26:49 INFO - mozversion platform_version: 46.0a1 00:26:49 INFO - using testdate: 1452500809 00:26:49 INFO - actual date: 1452500809 00:26:49 INFO - starting webserver on 'localhost:32806' 00:26:49 INFO - SUITE-START | Running 3 tests 00:26:49 INFO - TEST-START | dromaeo_css 00:26:49 INFO - operating with platform_type : linux_ 00:26:49 INFO - Initialising browser for dromaeo_css test... 00:26:49 INFO - TEST-INFO | started process 5136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ROjxl/profile http://localhost:32806/getInfo.html) 00:26:53 INFO - PROCESS | 5136 | 00:26:53 INFO - PROCESS | 5136 | (process:5218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:26:53 INFO - PROCESS | 5136 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 00:26:54 INFO - PROCESS | 5136 | __metrics Screen width/height:1600/1200 00:26:54 INFO - PROCESS | 5136 | colorDepth:24 00:26:54 INFO - PROCESS | 5136 | Browser inner width/height: 1024/697 00:26:54 INFO - PROCESS | 5136 | __metrics 00:26:54 INFO - PROCESS | 5136 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:26:55 INFO - TEST-INFO | 5136: exit 0 00:26:55 INFO - Browser initialized. 00:26:55 INFO - Running cycle 1/1 for dromaeo_css test... 00:26:55 INFO - TEST-INFO | started process 5267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ROjxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:26:56 INFO - PROCESS | 5267 | 00:26:56 INFO - PROCESS | 5267 | (process:5323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:27:07 INFO - PROCESS | 5267 | RSS: Main: 151064576 00:27:07 INFO - PROCESS | 5267 | 00:27:57 INFO - PROCESS | 5267 | 1452500877061 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] 00:30:08 INFO - PROCESS | 5267 | Cycle 1(1): loaded http://localhost:32806/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32806/tests/dromaeo/cssquery-ext.html) 00:30:09 INFO - PROCESS | 5267 | RSS: Main: 155078656 00:30:09 INFO - PROCESS | 5267 | 00:33:11 INFO - PROCESS | 5267 | Cycle 1(1): loaded http://localhost:32806/tests/dromaeo/cssquery-ext.html (next: http://localhost:32806/tests/dromaeo/cssquery-jquery.html) 00:33:12 INFO - PROCESS | 5267 | RSS: Main: 153391104 00:33:12 INFO - PROCESS | 5267 | 00:36:14 INFO - PROCESS | 5267 | Cycle 1(1): loaded http://localhost:32806/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32806/tests/dromaeo/cssquery-mootools.html) 00:36:14 INFO - PROCESS | 5267 | RSS: Main: 151064576 00:36:14 INFO - PROCESS | 5267 | 00:39:16 INFO - PROCESS | 5267 | Cycle 1(1): loaded http://localhost:32806/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32806/tests/dromaeo/cssquery-prototype.html) 00:39:17 INFO - PROCESS | 5267 | RSS: Main: 154447872 00:39:17 INFO - PROCESS | 5267 | 00:42:19 INFO - PROCESS | 5267 | Cycle 1(1): loaded http://localhost:32806/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32806/tests/dromaeo/cssquery-yui.html) 00:42:20 INFO - PROCESS | 5267 | RSS: Main: 153165824 00:42:20 INFO - PROCESS | 5267 | 00:45:22 INFO - PROCESS | 5267 | Cycle 1(1): loaded http://localhost:32806/tests/dromaeo/cssquery-yui.html (next: http://localhost:32806/tests/dromaeo/cssquery-dojo.html) 00:45:23 INFO - PROCESS | 5267 | RSS: Main: 159367168 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | __start_tp_report 00:45:23 INFO - PROCESS | 5267 | _x_x_mozilla_page_load 00:45:23 INFO - PROCESS | 5267 | _x_x_mozilla_page_load_details 00:45:23 INFO - PROCESS | 5267 | |i|pagename|runs| 00:45:23 INFO - PROCESS | 5267 | |0;dojo.html;2609.099860548111;2675.1706970839055;2707.282570118919;2731.1123884737467;2734.0294195560564;4539.160255352754;4706.270528068147;4714.245720684687;4717.080169366975;4717.999999999995;4529.614982726464;4569.200389931765;4636.304554316855;4673.415823022122;4676.0414115106405;4124.876253712393;4346.39150518926;4350.804213810378;4400;4445.444319460067;4089.141280331119;4375.978120109395;4390.495093064291;4442.666799989997;4450.198964186445;4158.2515147273325;4244.830206791725;4361.105973275471;4374.278244089722;4385.057212699253;4261.531231564525;4301.397804307399;4318.309070548728;4329.177456283296;4342.544032876534;4167.249895018896;4251.298535741599;4305.095929854734;4310.892227694301;4347.30443129101;4448.844290449819;4511.571400716959;4575.313702944552;4576.656750743674;4640.767961601907;4978.054169707744;4994.101061808873;4999.450060493343;5000.3249561309485;5000.624953128494;4846.733429661367;4961.156603377399;4968.7515624219;5053.065182941167;5076.847694569132;4645.605123564535;4662.463816661128;4678.485366609636;4692.671512994092;4694.741789201558;5093.974530127326;5098.872528186751;5112.5143111405105;5112.9744351278005;5159.561437277798;4761.928571071437;4794.568488835952;4878.999805039958;4904.362432883702;4938.111139994836;4925.630577706686;4933.728644924492;4943.036107958986;4945.530174633404;4992.600591952635;4883.072216278895;4887.755612219375;4901;4904.6321525885705;4931.235658472942;4773.9761301193275;4865.270209468537;4885.2427873679635;4948.38145231846;4987.850364489072;4186.330187170099;4188.246115699142;4196.853110141131;4200.306949353384;4218.2196293685765;3628.5101511296166;3690.225052738901;3716.498272733146;3718.6095459976855;3722.3113723961155;4203.810828512725;4231.4710661167355;4282.935755963663;4287.164003019381;4320.783960801948;5004.199328107486;5034.949650503448;5054.9241761373605;5063.797448102108;5087.4149472811105;4193.433886425354;4300.935485967713;4339.7396156230725;4342.240107981153;4366.8908277292685;4429.557044295545;4502.774861256924;4520.005598768265;4540.432445944257;4543.977280113579;4636.188666983265;4663.48701642819;4665.883352916204;4668.159731248408;4705.341252224623;4756.6908150970075;4841.927371089507;4881.658283920092;4889.63327750413;4927.901441971212;4659.184642687448;4707.152712511781;4711.764411779466;4726.456457507431;4766.976165119152;4893.192623217129;4908.460069392293;4914.336564563881;4926.605871530197;4950.529699678525;4966.5033496651495;4986.700797952134;4988.775505102207;5002.52476014778;5039.798408063636;4639.559241872017;4741.336212930261;4777.95222047775;4894.167991441393;4912.0175964807895;4844.46710861812;4865.9270110947655;4866.124097662455;4880.560749532559;4902.950970490249;4621.838235661736;4725.810967561259;4765.547273009059;4782.808687652594;4827;4752.453467851241;4793.832215872428;4851.539103785135;4858.878528036686;4893.290472881484;4759;4785.306130611111;4792.472827988849;4803.975980120077;4840.152973229741 00:45:23 INFO - PROCESS | 5267 | |1;ext.html;469.2749701710856;470.53182083826596;470.6399604302709;499.9350084489016;507;31100.844495777517;31527;31878.521822172686;31896.521552176706;32018.83990580047;31470.370592588133;32002.519962200586;32102.839485802597;32169.195770105758;32178;7445.702171913117;7603.847923041536;7669.5398276103615;7670;7677.654505547263;7241.094863142107;7281.4902956792785;7301.342879140876;7311.780646580611;7354.963225183867;7543.547387156761;7566.924330756705;7572.697092116308;7575.166731659513;7655.119661238945;7458.477906546516;7506.361959233472;7587.165411804697;7616.504927179715;7651.081870175559;7351.66917488709;7509.098908131059;7513.849723005509;7526.962365188194;7529.171791102975;32783.34433311321;32941.50587741162;32999.835000825085;33093.3381332372;33332;2813.704561021084;2843.40288539407;2857.557078652812;2879.1074766822353;2895.1459319500796;27006.72993270062;27223.319417014733;27240.455190896268;27348.58977115345;27632.228130591113;3241.5623890774677;3368.898933032013;3381.2392211752403;3394.62659107498;3515.9472607910902;208376;209920;210176;210513;210644;44435.777821110685;51150.488495115314;51713.224301635506;51784.48215517797;51832;39794.20411591752;54796.72601636966;55777;55983.44016559864;56061.71969140128;12411.379431028412;12530.498780048878;12559.748805023848;12579.937100314623;12580.370981451073;9453.101955314234;9464.100910413637;9477.620895164255;9493.240540756722;9558.187554057982;17014.659706805796;17240.65518689619;17263.065278902617;17274.395396161326;17970.191341389407;7150.606716630531;7199.056254811172;7269.8546029079125;7344.522606030591;7418.96290518544;804.3886646148852;821.8602837517636;887.4453466583385;893.6961433112643;943.5848226780195;21419.785802141778;21624.56750864974;21885.562288754136;22084.78533680663;22218.333449996528;915.327234482668;920.8802855628726;976.3995142987012;978.7699890525721;1101.5758932810766;13418.865811341957;13707.725845483035;14059.578212653636;14089.577312680636;14333.6416589584;255202;260652;260950;261294;262746;43217.13565728668;43512.78243608762;43774.34338484925;43823.56176438258;43881.78059109748;1192.6183621241119;1208.5347141350644;1214.7813393589063;1224.393925007127;1242.9502819887284;25093.74906250914;26040.95836166608;26167.345816354744;26239.868800656637;26363.60454593144;37737;37824.243515130096;37989.43015854709;38175.80912095533;38237.808810955765;243928;244111;245234;245364;245659;23912.760872391053;24599.50800984006;26291.73708262893;27746.722532774413;27883.16350509488;32108.518372223967;32329.838350808095;36123.09692257715;36551.81724091469;37330.44004339991;27705.72294277112;28352.149435516967;29533.409331813673;30188.94338698135;30719.232019198804;29015.709842901302;29709.405811883207;29734.702652974058;30739.231519212197;31534.526982094827;28194.154175374773;28257.293567660974;28677.426451470437;28768.568471472525;28833.855830720713;25586.74413255918;26805.731942681105;27559.724402755717;27628.723712763418;27680.169594912186;22258.443538911655;22310;22438;22563.210287639853;22605.773942260366 00:45:23 INFO - PROCESS | 5267 | |2;jquery.html;332.68561209656883;333.33000668655995;334.5128966136773;335.25071465275107;341.09269343546174;14460.493882714094;14791.92604036981;14830.925845370772;14855.034422762514;15476.226188690576;10031.097201251885;10279.434631095286;12328.691782705437;15019;15036.09783412996;4450.732956022633;4635.119327327797;4640.582347588716;5047.974760126194;5284.947150528503;5170.172772356424;5192.039472697563;5192.454792246816;5201.895962080756;5222.895542089156;5033;5054.292399064134;5293.761780719877;5294.57643388528;5770.134479828017;5161.535461808437;5177.974110129463;5180.663256888291;5195.246689230078;5216.061109000398;5797.913031304533;6013.947559177126;6076.693510895178;6096.96951515244;6103.267607887082;18103.72844407335;19603.509912252164;20252.5949481011;20299;20831;1905.3236101184018;1964.9607007859906;1989.950251243716;1997.540565669904;2086.8017538333834;12953.158044727063;13245.403956821967;13381.66545836352;13514.662133446644;13742.793858092036;1781.4638684487925;1820.9908950455163;1853.2401715296664;1858.1731129647312;1901.6386886491662;53911.46088539104;55298.72350638221;57144.428555714745;57429.425705742826;57999.99999999958;14733.116013039253;14757.893158013192;14773;14855.182964937032;14872.553823385315;21880.78119218819;21945.341639750834;22012.559748805255;22061.11755529761;22215.555688886132;8117.391195660349;8135.83728325442;8176.918230817616;8208.712695055645;8218.794530136674;6721.7311307548125;6804.353586409283;6805.863882722318;6836.6923488443135;6854.280300568368;7258.854822903512;7285.198628151005;7294.8905766413545;7301.634918254066;7314.195438501761;2862.484752744526;2914.9854250729036;2930.5164647832867;2934.622955406128;2995.5356919677483;391.3679407756453;395.30821063139507;401.78102933901096;422.8921624985609;427.6365089673815;10033.347832390871;10119.848202276971;10242.07821296072;10433.21750868688;10548;404.22187289468246;410.9054917368962;413.3985051749757;425.3555862867758;432.07104724841844;5508.862278442991;5676.829695109071;5705.2012718219485;5773.884522309614;5780.248567686174;402790;407370;408494;412306;416221;60139;63107;63944;64140;64550.677246613464;448.777854961796;453.29512607894384;454.72489144068027;455.1602293767993;456.1788780195701;9604.807903842024;9692.903070969482;9705.708828735149;9809.460479673686;9812.950935245279;31679;31724;31733.8413307932;31906.840465797522;32023;41043.79478102591;41127.38308925428;41233.58766412298;43055.1388972225;43322.35016474818;6620.470362371095;6711.865762684816;6828.0440738297675;6893.931060689329;6988.37104660583;8462.703805366782;9731.12419882214;9751.268654851056;9832.465801963494;10119.089281964658;7724.150343462327;8307.750767476986;8330.666773329;8431.241188293083;8547.444416112932;8787.692430764893;8818.91181088181;8955.731328060168;8974.057723939153;9271.814563708824;7292;7893.5658538778625;7977.92022079795;8054.798630034296;8293;6786.491013174131;6914.827129321807;6973.895391569232;6996.125484314461;7009.719611215698;7418.221086786026;7953.2842044216295;7986.600669966362;8061.717839875576;8069.556174410229 00:45:23 INFO - PROCESS | 5267 | |3;mootools.html;1406.4936622815785;1424.736423761604;1559.2515592515592;1732.956676083097;1754.6490701859623;6390.904136437957;6570.967145164267;7148.678309476073;7254.854902901945;7285.235050319719;7089.22018577956;7354.926450735491;7356.632168391586;7375.373093287077;7414.555126692402;2091.5607722378318;2117.026167962739;2118.8093071623553;2119.152339064371;2123.214410668055;2142.0682003328525;2155.1918030738475;2155.5904378168175;2158.125958986613;2172.16371696897;2063.0509965415927;2079.6360636888558;2086.801753833391;2095.0991073838245;2120.67129594913;2185.0604240176717;2186.3440967709626;2188.1356864038776;2192.199847055829;2196.6485362342028;2132.776058513865;2148.6239908016037;2148.7528934172615;2150.150690477268;2151.2040544998295;7344;7401.0748656417945;7424.925750742477;7451.217622149705;7468.775936721907;4277.593628605308;4363.803628836678;4374.934375984363;4388.4733831940375;4404.537523560012;2870.9138725838257;2916.300087978891;2922.8100173488656;2927.414517096568;2944.1903476543907;975.1954637424083;987.0622908237203;1001.9198464122853;1007.9848802267971;1008.7427705935013;9508.049195080506;9572.425654460685;9592.136707696342;9619.086186812312;9634.662786802499;3881.3207688654375;3948.1314110895555;3977.1449138435373;4001.2597669431248;4014.3175660137845;8320.916790832014;8335.749927502186;8353.707620233263;8357.707480238285;8384.916150838535;4312.417823593837;4323.329883868006;4325.02686895446;4341.630961368319;4382.6055654991205;3257.7393808495262;3345.9330813383594;3803.4294855771855;3988.16248587794;4013.13717550728;3346.7322614190807;3369.534252600127;3393.2025973896116;3403.659634036626;3417.5386322846593;993.5926270229171;1022.156720705421;1022.2077889635592;1032.194887987371;1035.6427032673716;941.4492521874643;961.038961038961;964.1370972979284;964.4020707161465;1091.661584908665;6859.142607174103;6866.622335771481;6891.724331026703;6925.030495730602;6927.411170050602;451.5597292639716;457.3322948495234;459.40277639069075;461.06173936040665;461.98614041578804;5182.611304152204;5235.712035838065;5273.973630131824;5281.287026251483;5283.233931079972;9204.95397523008;9341.439513629204;9478.857817132748;9566.61733530651;9593;9354.906450935403;9413.717588472357;9442.339036267533;9463.148316651534;9479.099485548863;7207.351338379466;7287.672054757549;7320.04839370889;7335.816604584928;7368.042154519985;6611.074449576967;6656.201255849329;6673.766418175341;6678.632675202716;6697.09589205451;8185;8351.457155284887;8352.916470835456;8383.245507904317;8453.323734101134;8548.74353769388;8614.913850861662;8644.78388040304;8793.340499462694;8799.164079412445;6177.073438984188;6178.196834411498;6184.876302474016;6331.493480521639;6345.619262844244;6777.254502004677;6781.186257649114;6793.728250870107;6804.149481314836;6856.588604683735;6171.197744293213;6231.470325022243;6245.812625621239;6343.524235682435;6430.7749228776765;6268.498520118471;6339.714712837841;6343.873122537431;6381.521385896169;6405.2313722351755;6646.966765166143;6771.713374458837;6805.1833779944745;6818.420434263143;6821;6196.504279657526;6202.41077097675;6239.656818874824;6280.309165991828;6329.367063293634;6009.2188015557695;6011.068284415923;6028.065649824109;6032.819015429544;6059.787907423219 00:45:23 INFO - PROCESS | 5267 | |4;prototype.html;304.0877367896311;315.9068074917899;316.77192421456556;321.13614377324996;321.19220161294334;5475.561955043597;5549.084401073818;5638.661680299185;5653;5678.744456499458;5487.6158668893195;5533.031719449091;5533.114701647737;5549.916751248735;5552.5280351170195;4183.6653067754505;4262.488501379823;4264.38166465863;4298.419713338691;4305.22505948929;4288.52826189119;4293.162833247518;4293.763842988635;4294.227039132955;4306.289462238727;4233.894152646178;4249.043965107857;4252.659787217015;4254.851080212193;4260.510041345238;4235.597618226264;4246.872593822175;4254.31930891056;4258.956555643872;4270.4234928284595;3760.8871733848027;3787.5265591801026;3800.296945065144;3800.5059342285604;3807.961920380816;5145.922811157836;5317.175837745117;5343.171808369709;5356.1697936819855;5369.382521010095;4969.975150124226;4975.527324904128;4976.850694479172;4983;4987.301777751118;5872.471477567039;5875.8531036724;5896.086106653433;5905.936931352355;5913.0539113742025;3998.6001399860074;4155.792210389468;4158.979205103986;4161.0845613964875;4165.875023749292;6032.396760323976;6067.484263837579;6085.148079268906;6095.299040610343;6105.145279660806;4245.766482843474;4254.936175957363;4272.636825869836;4272.6795490338345;4283.978580107079;4328.394024836525;4337.652987760972;4342.218400687906;4344.674149438804;4351.216780979391;4775.498572649891;4922.532359425849;4923.606111511142;4929.260610908321;4932.630052746058;5786.103154011135;5852.7658893643775;5857.619254748428;5867.090600956859;5872.853178670567;1525.3136088760102;1536.1397617334328;1541.9768703469456;1544.667896402279;1547.860692537677;1055.7360659835042;1059.1685526861377;1067.0449947297125;1078.6278733836814;1086.4024786367465;5031.899362012739;5057.519535644108;5057.949420505822;5068;5074.771635276422;5944;6100.847478813065;6107.96946015276;6117.632942023492;6133.662648554283;5073.365829271341;5103.7192954387865;5113.64204505681;5114.488551144856;5117.692938423632;3239.4654881944216;3247.3667634810986;3279.3605246976613;3290.7860989035635;3296.620888597842;5643.407442218508;5741.425857414225;5750.741216645261;5768.451997060272;5772.624779389326;6268.373162683695;6284.622922624657;6287.271000474906;6292.874142517124;6293.968530157412;5760.6255593386295;5768.336641286306;5769.711514424262;5770;5789.102689083199;5952.940470595412;5985.850353741192;6065;6086.786962456293;6096.29892562361;5912.408759124053;5923.229980102559;5936.109583562327;5952.226210592596;5957.3446920837805;5750.079987202028;5762.4525670061275;5766.192733017465;5769.711514424178;5775.797847075332;4110.198511290269;4137.296659567941;4140.3168477200925;4144.067584793397;4151.12826306479;5954.761809527744;6072.544559157993;6086.817395478142;6087.299960504599;6090.208272924669;5833.241678581757;5847.415258474119;5848.5028772553105;5850.707464626837;5859.824205273849;5828.271466066742;5834.7082645866685;5843.707814609167;5854.0340843760305;5859.472647461578;5589.385167631639;5672.376038635664;5678.403767604342;5724.112762521816;5724.542036636975;5868.471837534642;5868.618539794899;5871.706414679164;5873.647581145145;5882.029465138205;5477.780888764564;5656.151577263443;5673.631213971079;5710.5717071219;5746.051901436216 00:45:23 INFO - PROCESS | 5267 | |5;yui.html;650.421125198573;652.8074218105659;663.5719960625397;703.205377922947;756.8788993761;10709.946450267747;11173.776524469506;11176.720581985455;11188.888111118886;11214.495347709353;11074.390908500029;11140.275882067659;11151.776964460705;11160.776784464306;11171.329720216792;763.9006929099223;770.433731207562;778.1673609238118;789.4158322841114;790.6837265093951;782.0615261685971;786.0606575142707;791.1850793682487;792.3938187286701;792.5680504125237;822.5517093184229;822.5722624235424;824.9628766705513;825.4180802534229;828.2752591482453;813.6948644258404;815.5310696349623;818.643889907886;819.8729196974449;820.9917900820975;606.5693357716027;609.3206075226091;610.1305639463747;610.5146408605169;611.2573223533384;12313.384330783425;12386.318752468611;12414.503419863195;12460.252384856847;12487.250764954131;11399;11468.770624587461;11530.365829879353;11755.412229388581;12003.099767517471;9359.953200233955;9362.859557106649;9511.90488095124;9513.90486095137;9600.90399096007;3138.921526961821;3192.4413227685295;3202.8558714857654;3210.887618933326;3300.1914530939835;38849.417258741145;39478.40782388238;39519.40720889189;39619.207615847525;39633.60366396328;8939.284857211407;9206.723798286062;9214.078592140731;9301.02339254382;9305.534723263945;15619.843801562067;15704.29330680122;15721.292541835415;15753.606159845865;15808.920955395379;6412.35876412355;6460.3862633049785;6542.705578248991;6586.80239592813;6638.20341559016;3602.0814692253307;3660.231351416179;3660.5973342932257;3700.3524383233366;3727.049602351383;2632.670916135483;2647.9470410592066;2648.6027095935765;2663.933401664935;2664.4271481631154;461.7921935129205;462.17040412459716;473.3515084334484;483.97338146402285;484.02469024914825;582.7639805878626;591.5238233222211;604.7369394313399;636.7198432689602;636.9045242183437;7383.984020697807;7769.417293702882;7784.260495252942;7810.414218933603;7846.568438735811;470.1936179452256;604.7127614383132;616.6022915219659;616.8365383173463;640.7885397818709;3522.4011917974008;3694.612065733113;3711.6473934976134;3742.7941463219786;3776.811159442072;46813.06373872503;47067.76466117647;47180.764096179984;47289.5271047292;47416.05167896623;39252.803735981135;39287.41068883969;39514.40728389077;39609.80195099006;39643.80178099149;38159.618403815606;38254.61745382566;39297.821065368655;39332;39643.40534891979;7926.762197134095;8156.510609363457;8168;8225.506469611842;8368.163183681583;29149;29157.70842291635;30022.84988575043;30032.84983575068;30160;35503.11242218965;36044;37102.814485927396;37246;37386.252274953804;9824.214062875095;9988.101070903653;10066.245031622511;10138.49307534635;10183.847242291224;10091.545880435546;10165.339252948535;10201.84697229557;11313.321200727654;11608.535658573563;10154.390736555535;10229.181665466893;10250.846237306596;10318.742031449274;10749.301295415773;10468.371897686164;10474.21443391764;10490.947545262225;10605.46972651349;10779.299345542515;9162.587683554122;9343.439393636403;9797.349150628852;10220.488975551341;10224;8646.221840034426;8729.127087291221;8777;8921.866172007554;8985.326100542616;8702.47785132894;9218;9223.815523689624;9385;9414.717558473258 00:45:23 INFO - PROCESS | 5267 | __end_tp_report 00:45:23 INFO - PROCESS | 5267 | __start_cc_report 00:45:23 INFO - PROCESS | 5267 | _x_x_mozilla_cycle_collect,326 00:45:23 INFO - PROCESS | 5267 | __end_cc_report 00:45:23 INFO - PROCESS | 5267 | __startTimestamp1452501923139__endTimestamp 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | ------- Summary: start ------- 00:45:23 INFO - PROCESS | 5267 | Number of tests: 6 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | [#0] dojo.html Cycles:165 Average:4596.75 Median:4714.25 stddev:463.97 (9.8%) stddev-sans-first:438.41 00:45:23 INFO - PROCESS | 5267 | Values: 2609.1 2675.2 2707.3 2731.1 2734.0 4539.2 4706.3 4714.2 4717.1 4718.0 4529.6 4569.2 4636.3 4673.4 4676.0 4124.9 4346.4 4350.8 4400.0 4445.4 4089.1 4376.0 4390.5 4442.7 4450.2 4158.3 4244.8 4361.1 4374.3 4385.1 4261.5 4301.4 4318.3 4329.2 4342.5 4167.2 4251.3 4305.1 4310.9 4347.3 4448.8 4511.6 4575.3 4576.7 4640.8 4978.1 4994.1 4999.5 5000.3 5000.6 4846.7 4961.2 4968.8 5053.1 5076.8 4645.6 4662.5 4678.5 4692.7 4694.7 5094.0 5098.9 5112.5 5113.0 5159.6 4761.9 4794.6 4879.0 4904.4 4938.1 4925.6 4933.7 4943.0 4945.5 4992.6 4883.1 4887.8 4901.0 4904.6 4931.2 4774.0 4865.3 4885.2 4948.4 4987.9 4186.3 4188.2 4196.9 4200.3 4218.2 3628.5 3690.2 3716.5 3718.6 3722.3 4203.8 4231.5 4282.9 4287.2 4320.8 5004.2 5034.9 5054.9 5063.8 5087.4 4193.4 4300.9 4339.7 4342.2 4366.9 4429.6 4502.8 4520.0 4540.4 4544.0 4636.2 4663.5 4665.9 4668.2 4705.3 4756.7 4841.9 4881.7 4889.6 4927.9 4659.2 4707.2 4711.8 4726.5 4767.0 4893.2 4908.5 4914.3 4926.6 4950.5 4966.5 4986.7 4988.8 5002.5 5039.8 4639.6 4741.3 4778.0 4894.2 4912.0 4844.5 4865.9 4866.1 4880.6 4903.0 4621.8 4725.8 4765.5 4782.8 4827.0 4752.5 4793.8 4851.5 4858.9 4893.3 4759.0 4785.3 4792.5 4804.0 4840.2 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | [#1] ext.html Cycles:180 Average:38261.98 Median:31949.52 stddev:62429.43 (195.4%) stddev-sans-first:62540.07 00:45:23 INFO - PROCESS | 5267 | Values: 469.3 470.5 470.6 499.9 507.0 31100.8 31527.0 31878.5 31896.5 32018.8 31470.4 32002.5 32102.8 32169.2 32178.0 7445.7 7603.8 7669.5 7670.0 7677.7 7241.1 7281.5 7301.3 7311.8 7355.0 7543.5 7566.9 7572.7 7575.2 7655.1 7458.5 7506.4 7587.2 7616.5 7651.1 7351.7 7509.1 7513.8 7527.0 7529.2 32783.3 32941.5 32999.8 33093.3 33332.0 2813.7 2843.4 2857.6 2879.1 2895.1 27006.7 27223.3 27240.5 27348.6 27632.2 3241.6 3368.9 3381.2 3394.6 3515.9 208376.0 209920.0 210176.0 210513.0 210644.0 44435.8 51150.5 51713.2 51784.5 51832.0 39794.2 54796.7 55777.0 55983.4 56061.7 12411.4 12530.5 12559.7 12579.9 12580.4 9453.1 9464.1 9477.6 9493.2 9558.2 17014.7 17240.7 17263.1 17274.4 17970.2 7150.6 7199.1 7269.9 7344.5 7419.0 804.4 821.9 887.4 893.7 943.6 21419.8 21624.6 21885.6 22084.8 22218.3 915.3 920.9 976.4 978.8 1101.6 13418.9 13707.7 14059.6 14089.6 14333.6 255202.0 260652.0 260950.0 261294.0 262746.0 43217.1 43512.8 43774.3 43823.6 43881.8 1192.6 1208.5 1214.8 1224.4 1243.0 25093.7 26041.0 26167.3 26239.9 26363.6 37737.0 37824.2 37989.4 38175.8 38237.8 243928.0 244111.0 245234.0 245364.0 245659.0 23912.8 24599.5 26291.7 27746.7 27883.2 32108.5 32329.8 36123.1 36551.8 37330.4 27705.7 28352.1 29533.4 30188.9 30719.2 29015.7 29709.4 29734.7 30739.2 31534.5 28194.2 28257.3 28677.4 28768.6 28833.9 25586.7 26805.7 27559.7 27628.7 27680.2 22258.4 22310.0 22438.0 22563.2 22605.8 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | [#2] jquery.html Cycles:180 Average:23315.36 Median:5051.13 stddev:67001.15 (1326.5%) stddev-sans-first:67166.89 00:45:23 INFO - PROCESS | 5267 | Values: 332.7 333.3 334.5 335.3 341.1 14460.5 14791.9 14830.9 14855.0 15476.2 10031.1 10279.4 12328.7 15019.0 15036.1 4450.7 4635.1 4640.6 5048.0 5284.9 5170.2 5192.0 5192.5 5201.9 5222.9 5033.0 5054.3 5293.8 5294.6 5770.1 5161.5 5178.0 5180.7 5195.2 5216.1 5797.9 6013.9 6076.7 6097.0 6103.3 18103.7 19603.5 20252.6 20299.0 20831.0 1905.3 1965.0 1990.0 1997.5 2086.8 12953.2 13245.4 13381.7 13514.7 13742.8 1781.5 1821.0 1853.2 1858.2 1901.6 53911.5 55298.7 57144.4 57429.4 58000.0 14733.1 14757.9 14773.0 14855.2 14872.6 21880.8 21945.3 22012.6 22061.1 22215.6 8117.4 8135.8 8176.9 8208.7 8218.8 6721.7 6804.4 6805.9 6836.7 6854.3 7258.9 7285.2 7294.9 7301.6 7314.2 2862.5 2915.0 2930.5 2934.6 2995.5 391.4 395.3 401.8 422.9 427.6 10033.3 10119.8 10242.1 10433.2 10548.0 404.2 410.9 413.4 425.4 432.1 5508.9 5676.8 5705.2 5773.9 5780.2 402790.0 407370.0 408494.0 412306.0 416221.0 60139.0 63107.0 63944.0 64140.0 64550.7 448.8 453.3 454.7 455.2 456.2 9604.8 9692.9 9705.7 9809.5 9813.0 31679.0 31724.0 31733.8 31906.8 32023.0 41043.8 41127.4 41233.6 43055.1 43322.4 6620.5 6711.9 6828.0 6893.9 6988.4 8462.7 9731.1 9751.3 9832.5 10119.1 7724.2 8307.8 8330.7 8431.2 8547.4 8787.7 8818.9 8955.7 8974.1 9271.8 7292.0 7893.6 7977.9 8054.8 8293.0 6786.5 6914.8 6973.9 6996.1 7009.7 7418.2 7953.3 7986.6 8061.7 8069.6 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | [#3] mootools.html Cycles:180 Average:5130.98 Median:6242.73 stddev:2739.19 (43.9%) stddev-sans-first:2732.57 00:45:23 INFO - PROCESS | 5267 | Values: 1406.5 1424.7 1559.3 1733.0 1754.6 6390.9 6571.0 7148.7 7254.9 7285.2 7089.2 7354.9 7356.6 7375.4 7414.6 2091.6 2117.0 2118.8 2119.2 2123.2 2142.1 2155.2 2155.6 2158.1 2172.2 2063.1 2079.6 2086.8 2095.1 2120.7 2185.1 2186.3 2188.1 2192.2 2196.6 2132.8 2148.6 2148.8 2150.2 2151.2 7344.0 7401.1 7424.9 7451.2 7468.8 4277.6 4363.8 4374.9 4388.5 4404.5 2870.9 2916.3 2922.8 2927.4 2944.2 975.2 987.1 1001.9 1008.0 1008.7 9508.0 9572.4 9592.1 9619.1 9634.7 3881.3 3948.1 3977.1 4001.3 4014.3 8320.9 8335.7 8353.7 8357.7 8384.9 4312.4 4323.3 4325.0 4341.6 4382.6 3257.7 3345.9 3803.4 3988.2 4013.1 3346.7 3369.5 3393.2 3403.7 3417.5 993.6 1022.2 1022.2 1032.2 1035.6 941.4 961.0 964.1 964.4 1091.7 6859.1 6866.6 6891.7 6925.0 6927.4 451.6 457.3 459.4 461.1 462.0 5182.6 5235.7 5274.0 5281.3 5283.2 9205.0 9341.4 9478.9 9566.6 9593.0 9354.9 9413.7 9442.3 9463.1 9479.1 7207.4 7287.7 7320.0 7335.8 7368.0 6611.1 6656.2 6673.8 6678.6 6697.1 8185.0 8351.5 8352.9 8383.2 8453.3 8548.7 8614.9 8644.8 8793.3 8799.2 6177.1 6178.2 6184.9 6331.5 6345.6 6777.3 6781.2 6793.7 6804.1 6856.6 6171.2 6231.5 6245.8 6343.5 6430.8 6268.5 6339.7 6343.9 6381.5 6405.2 6647.0 6771.7 6805.2 6818.4 6821.0 6196.5 6202.4 6239.7 6280.3 6329.4 6009.2 6011.1 6028.1 6032.8 6059.8 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | [#4] prototype.html Cycles:180 Average:4854.90 Median:5476.67 stddev:1416.98 (25.9%) stddev-sans-first:1379.17 00:45:23 INFO - PROCESS | 5267 | Values: 304.1 315.9 316.8 321.1 321.2 5475.6 5549.1 5638.7 5653.0 5678.7 5487.6 5533.0 5533.1 5549.9 5552.5 4183.7 4262.5 4264.4 4298.4 4305.2 4288.5 4293.2 4293.8 4294.2 4306.3 4233.9 4249.0 4252.7 4254.9 4260.5 4235.6 4246.9 4254.3 4259.0 4270.4 3760.9 3787.5 3800.3 3800.5 3808.0 5145.9 5317.2 5343.2 5356.2 5369.4 4970.0 4975.5 4976.9 4983.0 4987.3 5872.5 5875.9 5896.1 5905.9 5913.1 3998.6 4155.8 4159.0 4161.1 4165.9 6032.4 6067.5 6085.1 6095.3 6105.1 4245.8 4254.9 4272.6 4272.7 4284.0 4328.4 4337.7 4342.2 4344.7 4351.2 4775.5 4922.5 4923.6 4929.3 4932.6 5786.1 5852.8 5857.6 5867.1 5872.9 1525.3 1536.1 1542.0 1544.7 1547.9 1055.7 1059.2 1067.0 1078.6 1086.4 5031.9 5057.5 5057.9 5068.0 5074.8 5944.0 6100.8 6108.0 6117.6 6133.7 5073.4 5103.7 5113.6 5114.5 5117.7 3239.5 3247.4 3279.4 3290.8 3296.6 5643.4 5741.4 5750.7 5768.5 5772.6 6268.4 6284.6 6287.3 6292.9 6294.0 5760.6 5768.3 5769.7 5770.0 5789.1 5952.9 5985.9 6065.0 6086.8 6096.3 5912.4 5923.2 5936.1 5952.2 5957.3 5750.1 5762.5 5766.2 5769.7 5775.8 4110.2 4137.3 4140.3 4144.1 4151.1 5954.8 6072.5 6086.8 6087.3 6090.2 5833.2 5847.4 5848.5 5850.7 5859.8 5828.3 5834.7 5843.7 5854.0 5859.5 5589.4 5672.4 5678.4 5724.1 5724.5 5868.5 5868.6 5871.7 5873.6 5882.0 5477.8 5656.2 5673.6 5710.6 5746.1 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - PROCESS | 5267 | [#5] yui.html Cycles:180 Average:11754.99 Median:461.98 stddev:12914.16 (2795.4%) stddev-sans-first:12923.46 00:45:23 INFO - PROCESS | 5267 | Values: 650.4 652.8 663.6 703.2 756.9 10709.9 11173.8 11176.7 11188.9 11214.5 11074.4 11140.3 11151.8 11160.8 11171.3 763.9 770.4 778.2 789.4 790.7 782.1 786.1 791.2 792.4 792.6 822.6 822.6 825.0 825.4 828.3 813.7 815.5 818.6 819.9 821.0 606.6 609.3 610.1 610.5 611.3 12313.4 12386.3 12414.5 12460.3 12487.3 11399.0 11468.8 11530.4 11755.4 12003.1 9360.0 9362.9 9511.9 9513.9 9600.9 3138.9 3192.4 3202.9 3210.9 3300.2 38849.4 39478.4 39519.4 39619.2 39633.6 8939.3 9206.7 9214.1 9301.0 9305.5 15619.8 15704.3 15721.3 15753.6 15808.9 6412.4 6460.4 6542.7 6586.8 6638.2 3602.1 3660.2 3660.6 3700.4 3727.0 2632.7 2647.9 2648.6 2663.9 2664.4 461.8 462.2 473.4 484.0 484.0 582.8 591.5 604.7 636.7 636.9 7384.0 7769.4 7784.3 7810.4 7846.6 470.2 604.7 616.6 616.8 640.8 3522.4 3694.6 3711.6 3742.8 3776.8 46813.1 47067.8 47180.8 47289.5 47416.1 39252.8 39287.4 39514.4 39609.8 39643.8 38159.6 38254.6 39297.8 39332.0 39643.4 7926.8 8156.5 8168.0 8225.5 8368.2 29149.0 29157.7 30022.8 30032.8 30160.0 35503.1 36044.0 37102.8 37246.0 37386.3 9824.2 9988.1 10066.2 10138.5 10183.8 10091.5 10165.3 10201.8 11313.3 11608.5 10154.4 10229.2 10250.8 10318.7 10749.3 10468.4 10474.2 10490.9 10605.5 10779.3 9162.6 9343.4 9797.3 10220.5 10224.0 8646.2 8729.1 8777.0 8921.9 8985.3 8702.5 9218.0 9223.8 9385.0 9414.7 00:45:23 INFO - PROCESS | 5267 | -------- Summary: end -------- 00:45:23 INFO - PROCESS | 5267 | 00:45:23 INFO - TEST-INFO | 5267: exit 0 00:45:23 INFO - TEST-OK | dromaeo_css | took 1114390ms 00:45:23 INFO - TEST-START | kraken 00:45:23 INFO - operating with platform_type : linux_ 00:45:23 INFO - Initialising browser for kraken test... 00:45:23 INFO - TEST-INFO | started process 5505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3fPUR5/profile http://localhost:32806/getInfo.html) 00:45:27 INFO - PROCESS | 5505 | 00:45:27 INFO - PROCESS | 5505 | (process:5577): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:45:27 INFO - PROCESS | 5505 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 00:45:28 INFO - PROCESS | 5505 | __metrics Screen width/height:1600/1200 00:45:28 INFO - PROCESS | 5505 | colorDepth:24 00:45:28 INFO - PROCESS | 5505 | Browser inner width/height: 1024/697 00:45:28 INFO - PROCESS | 5505 | __metrics 00:45:28 INFO - PROCESS | 5505 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:45:29 INFO - TEST-INFO | 5505: exit 0 00:45:29 INFO - Browser initialized. 00:45:29 INFO - Running cycle 1/1 for kraken test... 00:45:29 INFO - TEST-INFO | started process 5626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3fPUR5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:45:31 INFO - PROCESS | 5626 | 00:45:31 INFO - PROCESS | 5626 | (process:5685): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:45:41 INFO - PROCESS | 5626 | RSS: Main: 151011328 00:45:41 INFO - PROCESS | 5626 | 00:45:44 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32806/tests/kraken/driver.html?testName=audio-beat-detection) 00:45:44 INFO - PROCESS | 5626 | RSS: Main: 151527424 00:45:44 INFO - PROCESS | 5626 | 00:45:47 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32806/tests/kraken/driver.html?testName=audio-dft) 00:45:48 INFO - PROCESS | 5626 | RSS: Main: 152072192 00:45:48 INFO - PROCESS | 5626 | 00:45:51 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32806/tests/kraken/driver.html?testName=audio-fft) 00:45:51 INFO - PROCESS | 5626 | RSS: Main: 146391040 00:45:51 INFO - PROCESS | 5626 | 00:45:53 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32806/tests/kraken/driver.html?testName=audio-oscillator) 00:45:54 INFO - PROCESS | 5626 | RSS: Main: 147349504 00:45:54 INFO - PROCESS | 5626 | 00:45:56 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32806/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:45:57 INFO - PROCESS | 5626 | RSS: Main: 147402752 00:45:57 INFO - PROCESS | 5626 | 00:46:00 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32806/tests/kraken/driver.html?testName=imaging-darkroom) 00:46:00 INFO - PROCESS | 5626 | RSS: Main: 146358272 00:46:00 INFO - PROCESS | 5626 | 00:46:04 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32806/tests/kraken/driver.html?testName=imaging-desaturate) 00:46:04 INFO - PROCESS | 5626 | RSS: Main: 146644992 00:46:04 INFO - PROCESS | 5626 | 00:46:07 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32806/tests/kraken/driver.html?testName=json-parse-financial) 00:46:08 INFO - PROCESS | 5626 | RSS: Main: 146644992 00:46:08 INFO - PROCESS | 5626 | 00:46:10 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32806/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:46:10 INFO - PROCESS | 5626 | RSS: Main: 148836352 00:46:10 INFO - PROCESS | 5626 | 00:46:12 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:46:13 INFO - PROCESS | 5626 | RSS: Main: 148983808 00:46:13 INFO - PROCESS | 5626 | 00:46:15 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:46:16 INFO - PROCESS | 5626 | RSS: Main: 148811776 00:46:16 INFO - PROCESS | 5626 | 00:46:18 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:46:19 INFO - PROCESS | 5626 | RSS: Main: 147566592 00:46:19 INFO - PROCESS | 5626 | 00:46:21 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:46:22 INFO - PROCESS | 5626 | RSS: Main: 149553152 00:46:22 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | Cycle 1(1): loaded http://localhost:32806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32806/tests/kraken/driver.html?testName=ai-astar) 00:46:24 INFO - PROCESS | 5626 | RSS: Main: 149118976 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | __start_tp_report 00:46:24 INFO - PROCESS | 5626 | _x_x_mozilla_page_load 00:46:24 INFO - PROCESS | 5626 | _x_x_mozilla_page_load_details 00:46:24 INFO - PROCESS | 5626 | |i|pagename|runs| 00:46:24 INFO - PROCESS | 5626 | |0;ai-astar;113;109;112;114;113;125;112;113;113;117 00:46:24 INFO - PROCESS | 5626 | |1;audio-beat-detection;166;132;151;170;135;157;152;134;176;134 00:46:24 INFO - PROCESS | 5626 | |2;audio-dft;162;165;163;163;162;164;169;163;167;162 00:46:24 INFO - PROCESS | 5626 | |3;audio-fft;72;73;72;73;125;73;72;78;74;94 00:46:24 INFO - PROCESS | 5626 | |4;audio-oscillator;97;98;138;96;99;97;142;97;98;130 00:46:24 INFO - PROCESS | 5626 | |5;imaging-gaussian-blur;110;110;110;112;109;109;110;110;114;111 00:46:24 INFO - PROCESS | 5626 | |6;imaging-darkroom;147;149;147;150;147;147;148;147;149;148 00:46:24 INFO - PROCESS | 5626 | |7;imaging-desaturate;95;96;97;97;96;97;96;96;96;97 00:46:24 INFO - PROCESS | 5626 | |8;json-parse-financial;72;71;71;70;73;71;70;71;69;73 00:46:24 INFO - PROCESS | 5626 | |9;json-stringify-tinderbox;67;72;68;68;67;68;68;74;68;68 00:46:24 INFO - PROCESS | 5626 | |10;stanford-crypto-aes;83;91;85;94;93;84;86;85;85;92 00:46:24 INFO - PROCESS | 5626 | |11;stanford-crypto-ccm;125;120;125;131;123;127;119;130;121;126 00:46:24 INFO - PROCESS | 5626 | |12;stanford-crypto-pbkdf2;138;151;148;149;149;135;149;158;158;143 00:46:24 INFO - PROCESS | 5626 | |13;stanford-crypto-sha256-iterative;71;72;70;71;73;71;74;71;70;69 00:46:24 INFO - PROCESS | 5626 | __end_tp_report 00:46:24 INFO - PROCESS | 5626 | __start_cc_report 00:46:24 INFO - PROCESS | 5626 | _x_x_mozilla_cycle_collect,821 00:46:24 INFO - PROCESS | 5626 | __end_cc_report 00:46:24 INFO - PROCESS | 5626 | __startTimestamp1452501984457__endTimestamp 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | ------- Summary: start ------- 00:46:24 INFO - PROCESS | 5626 | Number of tests: 14 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.00 stddev:4.31 (3.8%) stddev-sans-first:4.55 00:46:24 INFO - PROCESS | 5626 | Values: 113.0 109.0 112.0 114.0 113.0 125.0 112.0 113.0 113.0 117.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:154.50 stddev:16.47 (10.7%) stddev-sans-first:16.52 00:46:24 INFO - PROCESS | 5626 | Values: 166.0 132.0 151.0 170.0 135.0 157.0 152.0 134.0 176.0 134.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.36 (1.4%) stddev-sans-first:2.39 00:46:24 INFO - PROCESS | 5626 | Values: 162.0 165.0 163.0 163.0 162.0 164.0 169.0 163.0 167.0 162.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:16.98 (23.3%) stddev-sans-first:17.73 00:46:24 INFO - PROCESS | 5626 | Values: 72.0 73.0 72.0 73.0 125.0 73.0 72.0 78.0 74.0 94.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:97.00 stddev:19.19 (19.8%) stddev-sans-first:19.84 00:46:24 INFO - PROCESS | 5626 | Values: 97.0 98.0 138.0 96.0 99.0 97.0 142.0 97.0 98.0 130.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:1.51 (1.4%) stddev-sans-first:1.59 00:46:24 INFO - PROCESS | 5626 | Values: 110.0 110.0 110.0 112.0 109.0 109.0 110.0 110.0 114.0 111.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 00:46:24 INFO - PROCESS | 5626 | Values: 147.0 149.0 147.0 150.0 147.0 147.0 148.0 147.0 149.0 148.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 00:46:24 INFO - PROCESS | 5626 | Values: 95.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 96.0 97.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:1.29 (1.8%) stddev-sans-first:1.32 00:46:24 INFO - PROCESS | 5626 | Values: 72.0 71.0 71.0 70.0 73.0 71.0 70.0 71.0 69.0 73.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:2.30 (3.4%) stddev-sans-first:2.35 00:46:24 INFO - PROCESS | 5626 | Values: 67.0 72.0 68.0 68.0 67.0 68.0 68.0 74.0 68.0 68.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.50 stddev:4.18 (4.7%) stddev-sans-first:4.06 00:46:24 INFO - PROCESS | 5626 | Values: 83.0 91.0 85.0 94.0 93.0 84.0 86.0 85.0 85.0 92.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:125.50 stddev:4.03 (3.2%) stddev-sans-first:4.27 00:46:24 INFO - PROCESS | 5626 | Values: 125.0 120.0 125.0 131.0 123.0 127.0 119.0 130.0 121.0 126.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.00 stddev:7.50 (5.0%) stddev-sans-first:7.06 00:46:24 INFO - PROCESS | 5626 | Values: 138.0 151.0 148.0 149.0 149.0 135.0 149.0 158.0 158.0 143.0 00:46:24 INFO - PROCESS | 5626 | 00:46:24 INFO - PROCESS | 5626 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 00:46:24 INFO - PROCESS | 5626 | Values: 71.0 72.0 70.0 71.0 73.0 71.0 74.0 71.0 70.0 69.0 00:46:24 INFO - PROCESS | 5626 | -------- Summary: end -------- 00:46:24 INFO - PROCESS | 5626 | 00:46:25 INFO - TEST-INFO | 5626: exit 0 00:46:25 INFO - TEST-OK | kraken | took 61579ms 00:46:25 INFO - TEST-START | v8_7 00:46:25 INFO - operating with platform_type : linux_ 00:46:25 INFO - Initialising browser for v8_7 test... 00:46:25 INFO - TEST-INFO | started process 5913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfTvg2Y/profile http://localhost:32806/getInfo.html) 00:46:29 INFO - PROCESS | 5913 | 00:46:29 INFO - PROCESS | 5913 | (process:5987): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:46:29 INFO - PROCESS | 5913 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 00:46:30 INFO - PROCESS | 5913 | __metrics Screen width/height:1600/1200 00:46:30 INFO - PROCESS | 5913 | colorDepth:24 00:46:30 INFO - PROCESS | 5913 | Browser inner width/height: 1024/697 00:46:30 INFO - PROCESS | 5913 | __metrics 00:46:30 INFO - PROCESS | 5913 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:46:31 INFO - TEST-INFO | 5913: exit 0 00:46:31 INFO - Browser initialized. 00:46:31 INFO - Running cycle 1/1 for v8_7 test... 00:46:31 INFO - TEST-INFO | started process 6036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfTvg2Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:46:32 INFO - PROCESS | 6036 | 00:46:32 INFO - PROCESS | 6036 | (process:6092): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:46:43 INFO - PROCESS | 6036 | RSS: Main: 150380544 00:46:43 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | Cycle 1(1): loaded http://localhost:32806/tests/v8_7/run.html (next: http://localhost:32806/tests/v8_7/run.html) 00:47:05 INFO - PROCESS | 6036 | RSS: Main: 145936384 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | __start_tp_report 00:47:05 INFO - PROCESS | 6036 | _x_x_mozilla_page_load 00:47:05 INFO - PROCESS | 6036 | _x_x_mozilla_page_load_details 00:47:05 INFO - PROCESS | 6036 | |i|pagename|runs| 00:47:05 INFO - PROCESS | 6036 | |0;Richards;166.41704110500916 00:47:05 INFO - PROCESS | 6036 | |1;DeltaBlue;186.9158878504673 00:47:05 INFO - PROCESS | 6036 | |2;Encrypt;278.00945232137894 00:47:05 INFO - PROCESS | 6036 | |3;Decrypt;5181.347150259067 00:47:05 INFO - PROCESS | 6036 | |4;RayTrace;1060.4453870625662 00:47:05 INFO - PROCESS | 6036 | |5;Earley;714.2857142857143 00:47:05 INFO - PROCESS | 6036 | |6;Boyer;12612.5 00:47:05 INFO - PROCESS | 6036 | |7;RegExp;43297.87234042553 00:47:05 INFO - PROCESS | 6036 | |8;Splay;597.0149253731344 00:47:05 INFO - PROCESS | 6036 | |9;NavierStokes;4859.223300970873 00:47:05 INFO - PROCESS | 6036 | __end_tp_report 00:47:05 INFO - PROCESS | 6036 | __startTimestamp1452502025782__endTimestamp 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | ------- Summary: start ------- 00:47:05 INFO - PROCESS | 6036 | Number of tests: 10 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 166.4 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#1] DeltaBlue Cycles:1 Average:186.92 Median:186.92 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 186.9 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 278.0 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 5181.3 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 1060.4 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 714.3 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#6] Boyer Cycles:1 Average:12612.50 Median:12612.50 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 12612.5 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#7] RegExp Cycles:1 Average:43297.87 Median:43297.87 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 43297.9 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#8] Splay Cycles:1 Average:597.01 Median:597.01 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 597.0 00:47:05 INFO - PROCESS | 6036 | 00:47:05 INFO - PROCESS | 6036 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 00:47:05 INFO - PROCESS | 6036 | Values: 4859.2 00:47:05 INFO - PROCESS | 6036 | -------- Summary: end -------- 00:47:05 INFO - PROCESS | 6036 | 00:47:06 INFO - TEST-INFO | 6036: exit 0 00:47:06 INFO - TEST-OK | v8_7 | took 41268ms 00:47:06 INFO - SUITE-END | took 1217s 00:47:06 INFO - Completed test suite (00:20:17) 00:47:06 INFO - Working with test: dromaeo_css 00:47:06 INFO - Generating results file: dromaeo_css 00:47:06 INFO - Working with test: kraken 00:47:06 INFO - Generating results file: kraken 00:47:06 INFO - javascript benchmark 00:47:06 INFO - Working with test: v8_7 00:47:06 INFO - Generating results file: v8_7 00:47:06 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 00:47:06 INFO - process_Request line: dromaeo_css 6143.35 graph.html#tests=[[72,132,43]] 00:47:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:06 INFO - process_Request line: kraken 1544.70 graph.html#tests=[[232,132,43]] 00:47:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:06 INFO - process_Request line: v8_7 20283.83 graph.html#tests=[[230,132,43]] 00:47:06 INFO - RETURN: dromaeo_css: 6143.35 00:47:06 INFO - RETURN: kraken: 1544.70 00:47:06 INFO - RETURN: v8_7: 20283.83 00:47:06 INFO - javascript benchmark 00:47:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2609.099860548111, 2675.1706970839055, 2707.282570118919, 2731.1123884737467, 2734.0294195560564, 4539.160255352754, 4706.270528068147, 4714.245720684687, 4717.080169366975, 4717.999999999995, 4529.614982726464, 4569.200389931765, 4636.304554316855, 4673.415823022122, 4676.0414115106405, 4124.876253712393, 4346.39150518926, 4350.804213810378, 4400.0, 4445.444319460067, 4089.141280331119, 4375.978120109395, 4390.495093064291, 4442.666799989997, 4450.198964186445, 4158.2515147273325, 4244.830206791725, 4361.105973275471, 4374.278244089722, 4385.057212699253, 4261.531231564525, 4301.397804307399, 4318.309070548728, 4329.177456283296, 4342.544032876534, 4167.249895018896, 4251.298535741599, 4305.095929854734, 4310.892227694301, 4347.30443129101, 4448.844290449819, 4511.571400716959, 4575.313702944552, 4576.656750743674, 4640.767961601907, 4978.054169707744, 4994.101061808873, 4999.450060493343, 5000.3249561309485, 5000.624953128494, 4846.733429661367, 4961.156603377399, 4968.7515624219, 5053.065182941167, 5076.847694569132, 4645.605123564535, 4662.463816661128, 4678.485366609636, 4692.671512994092, 4694.741789201558, 5093.974530127326, 5098.872528186751, 5112.5143111405105, 5112.9744351278005, 5159.561437277798, 4761.928571071437, 4794.568488835952, 4878.999805039958, 4904.362432883702, 4938.111139994836, 4925.630577706686, 4933.728644924492, 4943.036107958986, 4945.530174633404, 4992.600591952635, 4883.072216278895, 4887.755612219375, 4901.0, 4904.6321525885705, 4931.235658472942, 4773.9761301193275, 4865.270209468537, 4885.2427873679635, 4948.38145231846, 4987.850364489072, 4186.330187170099, 4188.246115699142, 4196.853110141131, 4200.306949353384, 4218.2196293685765, 3628.5101511296166, 3690.225052738901, 3716.498272733146, 3718.6095459976855, 3722.3113723961155, 4203.810828512725, 4231.4710661167355, 4282.935755963663, 4287.164003019381, 4320.783960801948, 5004.199328107486, 5034.949650503448, 5054.9241761373605, 5063.797448102108, 5087.4149472811105, 4193.433886425354, 4300.935485967713, 4339.7396156230725, 4342.240107981153, 4366.8908277292685, 4429.557044295545, 4502.774861256924, 4520.005598768265, 4540.432445944257, 4543.977280113579, 4636.188666983265, 4663.48701642819, 4665.883352916204, 4668.159731248408, 4705.341252224623, 4756.6908150970075, 4841.927371089507, 4881.658283920092, 4889.63327750413, 4927.901441971212, 4659.184642687448, 4707.152712511781, 4711.764411779466, 4726.456457507431, 4766.976165119152, 4893.192623217129, 4908.460069392293, 4914.336564563881, 4926.605871530197, 4950.529699678525, 4966.5033496651495, 4986.700797952134, 4988.775505102207, 5002.52476014778, 5039.798408063636, 4639.559241872017, 4741.336212930261, 4777.95222047775, 4894.167991441393, 4912.0175964807895, 4844.46710861812, 4865.9270110947655, 4866.124097662455, 4880.560749532559, 4902.950970490249, 4621.838235661736, 4725.810967561259, 4765.547273009059, 4782.808687652594, 4827.0, 4752.453467851241, 4793.832215872428, 4851.539103785135, 4858.878528036686, 4893.290472881484, 4759.0, 4785.306130611111, 4792.472827988849, 4803.975980120077, 4840.152973229741], "unit": "score", "name": "dojo.html", "value": 4568.825458349956}, {"lowerIsBetter": false, "replicates": [469.2749701710856, 470.53182083826596, 470.6399604302709, 499.9350084489016, 507.0, 31100.844495777517, 31527.0, 31878.521822172686, 31896.521552176706, 32018.83990580047, 31470.370592588133, 32002.519962200586, 32102.839485802597, 32169.195770105758, 32178.0, 7445.702171913117, 7603.847923041536, 7669.5398276103615, 7670.0, 7677.654505547263, 7241.094863142107, 7281.4902956792785, 7301.342879140876, 7311.780646580611, 7354.963225183867, 7543.547387156761, 7566.924330756705, 7572.697092116308, 7575.166731659513, 7655.119661238945, 7458.477906546516, 7506.361959233472, 7587.165411804697, 7616.504927179715, 7651.081870175559, 7351.66917488709, 7509.098908131059, 7513.849723005509, 7526.962365188194, 7529.171791102975, 32783.34433311321, 32941.50587741162, 32999.835000825085, 33093.3381332372, 33332.0, 2813.704561021084, 2843.40288539407, 2857.557078652812, 2879.1074766822353, 2895.1459319500796, 27006.72993270062, 27223.319417014733, 27240.455190896268, 27348.58977115345, 27632.228130591113, 3241.5623890774677, 3368.898933032013, 3381.2392211752403, 3394.62659107498, 3515.9472607910902, 208376.0, 209920.0, 210176.0, 210513.0, 210644.0, 44435.777821110685, 51150.488495115314, 51713.224301635506, 51784.48215517797, 51832.0, 39794.20411591752, 54796.72601636966, 55777.0, 55983.44016559864, 56061.71969140128, 12411.379431028412, 12530.498780048878, 12559.748805023848, 12579.937100314623, 12580.370981451073, 9453.101955314234, 9464.100910413637, 9477.620895164255, 9493.240540756722, 9558.187554057982, 17014.659706805796, 17240.65518689619, 17263.065278902617, 17274.395396161326, 17970.191341389407, 7150.606716630531, 7199.056254811172, 7269.8546029079125, 7344.522606030591, 7418.96290518544, 804.3886646148852, 821.8602837517636, 887.4453466583385, 893.6961433112643, 943.5848226780195, 21419.785802141778, 21624.56750864974, 21885.562288754136, 22084.78533680663, 22218.333449996528, 915.327234482668, 920.8802855628726, 976.3995142987012, 978.7699890525721, 1101.5758932810766, 13418.865811341957, 13707.725845483035, 14059.578212653636, 14089.577312680636, 14333.6416589584, 255202.0, 260652.0, 260950.0, 261294.0, 262746.0, 43217.13565728668, 43512.78243608762, 43774.34338484925, 43823.56176438258, 43881.78059109748, 1192.6183621241119, 1208.5347141350644, 1214.7813393589063, 1224.393925007127, 1242.9502819887284, 25093.74906250914, 26040.95836166608, 26167.345816354744, 26239.868800656637, 26363.60454593144, 37737.0, 37824.243515130096, 37989.43015854709, 38175.80912095533, 38237.808810955765, 243928.0, 244111.0, 245234.0, 245364.0, 245659.0, 23912.760872391053, 24599.50800984006, 26291.73708262893, 27746.722532774413, 27883.16350509488, 32108.518372223967, 32329.838350808095, 36123.09692257715, 36551.81724091469, 37330.44004339991, 27705.72294277112, 28352.149435516967, 29533.409331813673, 30188.94338698135, 30719.232019198804, 29015.709842901302, 29709.405811883207, 29734.702652974058, 30739.231519212197, 31534.526982094827, 28194.154175374773, 28257.293567660974, 28677.426451470437, 28768.568471472525, 28833.855830720713, 25586.74413255918, 26805.731942681105, 27559.724402755717, 27628.723712763418, 27680.169594912186, 22258.443538911655, 22310.0, 22438.0, 22563.210287639853, 22605.773942260366], "unit": "score", "name": "ext.html", "value": 15657.392363577905}, {"lowerIsBetter": false, "replicates": [332.68561209656883, 333.33000668655995, 334.5128966136773, 335.25071465275107, 341.09269343546174, 14460.493882714094, 14791.92604036981, 14830.925845370772, 14855.034422762514, 15476.226188690576, 10031.097201251885, 10279.434631095286, 12328.691782705437, 15019.0, 15036.09783412996, 4450.732956022633, 4635.119327327797, 4640.582347588716, 5047.974760126194, 5284.947150528503, 5170.172772356424, 5192.039472697563, 5192.454792246816, 5201.895962080756, 5222.895542089156, 5033.0, 5054.292399064134, 5293.761780719877, 5294.57643388528, 5770.134479828017, 5161.535461808437, 5177.974110129463, 5180.663256888291, 5195.246689230078, 5216.061109000398, 5797.913031304533, 6013.947559177126, 6076.693510895178, 6096.96951515244, 6103.267607887082, 18103.72844407335, 19603.509912252164, 20252.5949481011, 20299.0, 20831.0, 1905.3236101184018, 1964.9607007859906, 1989.950251243716, 1997.540565669904, 2086.8017538333834, 12953.158044727063, 13245.403956821967, 13381.66545836352, 13514.662133446644, 13742.793858092036, 1781.4638684487925, 1820.9908950455163, 1853.2401715296664, 1858.1731129647312, 1901.6386886491662, 53911.46088539104, 55298.72350638221, 57144.428555714745, 57429.425705742826, 57999.99999999958, 14733.116013039253, 14757.893158013192, 14773.0, 14855.182964937032, 14872.553823385315, 21880.78119218819, 21945.341639750834, 22012.559748805255, 22061.11755529761, 22215.555688886132, 8117.391195660349, 8135.83728325442, 8176.918230817616, 8208.712695055645, 8218.794530136674, 6721.7311307548125, 6804.353586409283, 6805.863882722318, 6836.6923488443135, 6854.280300568368, 7258.854822903512, 7285.198628151005, 7294.8905766413545, 7301.634918254066, 7314.195438501761, 2862.484752744526, 2914.9854250729036, 2930.5164647832867, 2934.622955406128, 2995.5356919677483, 391.3679407756453, 395.30821063139507, 401.78102933901096, 422.8921624985609, 427.6365089673815, 10033.347832390871, 10119.848202276971, 10242.07821296072, 10433.21750868688, 10548.0, 404.22187289468246, 410.9054917368962, 413.3985051749757, 425.3555862867758, 432.07104724841844, 5508.862278442991, 5676.829695109071, 5705.2012718219485, 5773.884522309614, 5780.248567686174, 402790.0, 407370.0, 408494.0, 412306.0, 416221.0, 60139.0, 63107.0, 63944.0, 64140.0, 64550.677246613464, 448.777854961796, 453.29512607894384, 454.72489144068027, 455.1602293767993, 456.1788780195701, 9604.807903842024, 9692.903070969482, 9705.708828735149, 9809.460479673686, 9812.950935245279, 31679.0, 31724.0, 31733.8413307932, 31906.840465797522, 32023.0, 41043.79478102591, 41127.38308925428, 41233.58766412298, 43055.1388972225, 43322.35016474818, 6620.470362371095, 6711.865762684816, 6828.0440738297675, 6893.931060689329, 6988.37104660583, 8462.703805366782, 9731.12419882214, 9751.268654851056, 9832.465801963494, 10119.089281964658, 7724.150343462327, 8307.750767476986, 8330.666773329, 8431.241188293083, 8547.444416112932, 8787.692430764893, 8818.91181088181, 8955.731328060168, 8974.057723939153, 9271.814563708824, 7292.0, 7893.5658538778625, 7977.92022079795, 8054.798630034296, 8293.0, 6786.491013174131, 6914.827129321807, 6973.895391569232, 6996.125484314461, 7009.719611215698, 7418.221086786026, 7953.2842044216295, 7986.600669966362, 8061.717839875576, 8069.556174410229], "unit": "score", "name": "jquery.html", "value": 7376.659836573653}, {"lowerIsBetter": false, "replicates": [1406.4936622815785, 1424.736423761604, 1559.2515592515592, 1732.956676083097, 1754.6490701859623, 6390.904136437957, 6570.967145164267, 7148.678309476073, 7254.854902901945, 7285.235050319719, 7089.22018577956, 7354.926450735491, 7356.632168391586, 7375.373093287077, 7414.555126692402, 2091.5607722378318, 2117.026167962739, 2118.8093071623553, 2119.152339064371, 2123.214410668055, 2142.0682003328525, 2155.1918030738475, 2155.5904378168175, 2158.125958986613, 2172.16371696897, 2063.0509965415927, 2079.6360636888558, 2086.801753833391, 2095.0991073838245, 2120.67129594913, 2185.0604240176717, 2186.3440967709626, 2188.1356864038776, 2192.199847055829, 2196.6485362342028, 2132.776058513865, 2148.6239908016037, 2148.7528934172615, 2150.150690477268, 2151.2040544998295, 7344.0, 7401.0748656417945, 7424.925750742477, 7451.217622149705, 7468.775936721907, 4277.593628605308, 4363.803628836678, 4374.934375984363, 4388.4733831940375, 4404.537523560012, 2870.9138725838257, 2916.300087978891, 2922.8100173488656, 2927.414517096568, 2944.1903476543907, 975.1954637424083, 987.0622908237203, 1001.9198464122853, 1007.9848802267971, 1008.7427705935013, 9508.049195080506, 9572.425654460685, 9592.136707696342, 9619.086186812312, 9634.662786802499, 3881.3207688654375, 3948.1314110895555, 3977.1449138435373, 4001.2597669431248, 4014.3175660137845, 8320.916790832014, 8335.749927502186, 8353.707620233263, 8357.707480238285, 8384.916150838535, 4312.417823593837, 4323.329883868006, 4325.02686895446, 4341.630961368319, 4382.6055654991205, 3257.7393808495262, 3345.9330813383594, 3803.4294855771855, 3988.16248587794, 4013.13717550728, 3346.7322614190807, 3369.534252600127, 3393.2025973896116, 3403.659634036626, 3417.5386322846593, 993.5926270229171, 1022.156720705421, 1022.2077889635592, 1032.194887987371, 1035.6427032673716, 941.4492521874643, 961.038961038961, 964.1370972979284, 964.4020707161465, 1091.661584908665, 6859.142607174103, 6866.622335771481, 6891.724331026703, 6925.030495730602, 6927.411170050602, 451.5597292639716, 457.3322948495234, 459.40277639069075, 461.06173936040665, 461.98614041578804, 5182.611304152204, 5235.712035838065, 5273.973630131824, 5281.287026251483, 5283.233931079972, 9204.95397523008, 9341.439513629204, 9478.857817132748, 9566.61733530651, 9593.0, 9354.906450935403, 9413.717588472357, 9442.339036267533, 9463.148316651534, 9479.099485548863, 7207.351338379466, 7287.672054757549, 7320.04839370889, 7335.816604584928, 7368.042154519985, 6611.074449576967, 6656.201255849329, 6673.766418175341, 6678.632675202716, 6697.09589205451, 8185.0, 8351.457155284887, 8352.916470835456, 8383.245507904317, 8453.323734101134, 8548.74353769388, 8614.913850861662, 8644.78388040304, 8793.340499462694, 8799.164079412445, 6177.073438984188, 6178.196834411498, 6184.876302474016, 6331.493480521639, 6345.619262844244, 6777.254502004677, 6781.186257649114, 6793.728250870107, 6804.149481314836, 6856.588604683735, 6171.197744293213, 6231.470325022243, 6245.812625621239, 6343.524235682435, 6430.7749228776765, 6268.498520118471, 6339.714712837841, 6343.873122537431, 6381.521385896169, 6405.2313722351755, 6646.966765166143, 6771.713374458837, 6805.1833779944745, 6818.420434263143, 6821.0, 6196.504279657526, 6202.41077097675, 6239.656818874824, 6280.309165991828, 6329.367063293634, 6009.2188015557695, 6011.068284415923, 6028.065649824109, 6032.819015429544, 6059.787907423219], "unit": "score", "name": "mootools.html", "value": 4114.993123727793}, {"lowerIsBetter": false, "replicates": [304.0877367896311, 315.9068074917899, 316.77192421456556, 321.13614377324996, 321.19220161294334, 5475.561955043597, 5549.084401073818, 5638.661680299185, 5653.0, 5678.744456499458, 5487.6158668893195, 5533.031719449091, 5533.114701647737, 5549.916751248735, 5552.5280351170195, 4183.6653067754505, 4262.488501379823, 4264.38166465863, 4298.419713338691, 4305.22505948929, 4288.52826189119, 4293.162833247518, 4293.763842988635, 4294.227039132955, 4306.289462238727, 4233.894152646178, 4249.043965107857, 4252.659787217015, 4254.851080212193, 4260.510041345238, 4235.597618226264, 4246.872593822175, 4254.31930891056, 4258.956555643872, 4270.4234928284595, 3760.8871733848027, 3787.5265591801026, 3800.296945065144, 3800.5059342285604, 3807.961920380816, 5145.922811157836, 5317.175837745117, 5343.171808369709, 5356.1697936819855, 5369.382521010095, 4969.975150124226, 4975.527324904128, 4976.850694479172, 4983.0, 4987.301777751118, 5872.471477567039, 5875.8531036724, 5896.086106653433, 5905.936931352355, 5913.0539113742025, 3998.6001399860074, 4155.792210389468, 4158.979205103986, 4161.0845613964875, 4165.875023749292, 6032.396760323976, 6067.484263837579, 6085.148079268906, 6095.299040610343, 6105.145279660806, 4245.766482843474, 4254.936175957363, 4272.636825869836, 4272.6795490338345, 4283.978580107079, 4328.394024836525, 4337.652987760972, 4342.218400687906, 4344.674149438804, 4351.216780979391, 4775.498572649891, 4922.532359425849, 4923.606111511142, 4929.260610908321, 4932.630052746058, 5786.103154011135, 5852.7658893643775, 5857.619254748428, 5867.090600956859, 5872.853178670567, 1525.3136088760102, 1536.1397617334328, 1541.9768703469456, 1544.667896402279, 1547.860692537677, 1055.7360659835042, 1059.1685526861377, 1067.0449947297125, 1078.6278733836814, 1086.4024786367465, 5031.899362012739, 5057.519535644108, 5057.949420505822, 5068.0, 5074.771635276422, 5944.0, 6100.847478813065, 6107.96946015276, 6117.632942023492, 6133.662648554283, 5073.365829271341, 5103.7192954387865, 5113.64204505681, 5114.488551144856, 5117.692938423632, 3239.4654881944216, 3247.3667634810986, 3279.3605246976613, 3290.7860989035635, 3296.620888597842, 5643.407442218508, 5741.425857414225, 5750.741216645261, 5768.451997060272, 5772.624779389326, 6268.373162683695, 6284.622922624657, 6287.271000474906, 6292.874142517124, 6293.968530157412, 5760.6255593386295, 5768.336641286306, 5769.711514424262, 5770.0, 5789.102689083199, 5952.940470595412, 5985.850353741192, 6065.0, 6086.786962456293, 6096.29892562361, 5912.408759124053, 5923.229980102559, 5936.109583562327, 5952.226210592596, 5957.3446920837805, 5750.079987202028, 5762.4525670061275, 5766.192733017465, 5769.711514424178, 5775.797847075332, 4110.198511290269, 4137.296659567941, 4140.3168477200925, 4144.067584793397, 4151.12826306479, 5954.761809527744, 6072.544559157993, 6086.817395478142, 6087.299960504599, 6090.208272924669, 5833.241678581757, 5847.415258474119, 5848.5028772553105, 5850.707464626837, 5859.824205273849, 5828.271466066742, 5834.7082645866685, 5843.707814609167, 5854.0340843760305, 5859.472647461578, 5589.385167631639, 5672.376038635664, 5678.403767604342, 5724.112762521816, 5724.542036636975, 5868.471837534642, 5868.618539794899, 5871.706414679164, 5873.647581145145, 5882.029465138205, 5477.780888764564, 5656.151577263443, 5673.631213971079, 5710.5717071219, 5746.051901436216], "unit": "score", "name": "prototype.html", "value": 4402.943746629215}, {"lowerIsBetter": false, "replicates": [650.421125198573, 652.8074218105659, 663.5719960625397, 703.205377922947, 756.8788993761, 10709.946450267747, 11173.776524469506, 11176.720581985455, 11188.888111118886, 11214.495347709353, 11074.390908500029, 11140.275882067659, 11151.776964460705, 11160.776784464306, 11171.329720216792, 763.9006929099223, 770.433731207562, 778.1673609238118, 789.4158322841114, 790.6837265093951, 782.0615261685971, 786.0606575142707, 791.1850793682487, 792.3938187286701, 792.5680504125237, 822.5517093184229, 822.5722624235424, 824.9628766705513, 825.4180802534229, 828.2752591482453, 813.6948644258404, 815.5310696349623, 818.643889907886, 819.8729196974449, 820.9917900820975, 606.5693357716027, 609.3206075226091, 610.1305639463747, 610.5146408605169, 611.2573223533384, 12313.384330783425, 12386.318752468611, 12414.503419863195, 12460.252384856847, 12487.250764954131, 11399.0, 11468.770624587461, 11530.365829879353, 11755.412229388581, 12003.099767517471, 9359.953200233955, 9362.859557106649, 9511.90488095124, 9513.90486095137, 9600.90399096007, 3138.921526961821, 3192.4413227685295, 3202.8558714857654, 3210.887618933326, 3300.1914530939835, 38849.417258741145, 39478.40782388238, 39519.40720889189, 39619.207615847525, 39633.60366396328, 8939.284857211407, 9206.723798286062, 9214.078592140731, 9301.02339254382, 9305.534723263945, 15619.843801562067, 15704.29330680122, 15721.292541835415, 15753.606159845865, 15808.920955395379, 6412.35876412355, 6460.3862633049785, 6542.705578248991, 6586.80239592813, 6638.20341559016, 3602.0814692253307, 3660.231351416179, 3660.5973342932257, 3700.3524383233366, 3727.049602351383, 2632.670916135483, 2647.9470410592066, 2648.6027095935765, 2663.933401664935, 2664.4271481631154, 461.7921935129205, 462.17040412459716, 473.3515084334484, 483.97338146402285, 484.02469024914825, 582.7639805878626, 591.5238233222211, 604.7369394313399, 636.7198432689602, 636.9045242183437, 7383.984020697807, 7769.417293702882, 7784.260495252942, 7810.414218933603, 7846.568438735811, 470.1936179452256, 604.7127614383132, 616.6022915219659, 616.8365383173463, 640.7885397818709, 3522.4011917974008, 3694.612065733113, 3711.6473934976134, 3742.7941463219786, 3776.811159442072, 46813.06373872503, 47067.76466117647, 47180.764096179984, 47289.5271047292, 47416.05167896623, 39252.803735981135, 39287.41068883969, 39514.40728389077, 39609.80195099006, 39643.80178099149, 38159.618403815606, 38254.61745382566, 39297.821065368655, 39332.0, 39643.40534891979, 7926.762197134095, 8156.510609363457, 8168.0, 8225.506469611842, 8368.163183681583, 29149.0, 29157.70842291635, 30022.84988575043, 30032.84983575068, 30160.0, 35503.11242218965, 36044.0, 37102.814485927396, 37246.0, 37386.252274953804, 9824.214062875095, 9988.101070903653, 10066.245031622511, 10138.49307534635, 10183.847242291224, 10091.545880435546, 10165.339252948535, 10201.84697229557, 11313.321200727654, 11608.535658573563, 10154.390736555535, 10229.181665466893, 10250.846237306596, 10318.742031449274, 10749.301295415773, 10468.371897686164, 10474.21443391764, 10490.947545262225, 10605.46972651349, 10779.299345542515, 9162.587683554122, 9343.439393636403, 9797.349150628852, 10220.488975551341, 10224.0, 8646.221840034426, 8729.127087291221, 8777.0, 8921.866172007554, 8985.326100542616, 8702.47785132894, 9218.0, 9223.815523689624, 9385.0, 9414.717558473258], "unit": "score", "name": "yui.html", "value": 5622.076185109097}], "name": "dromaeo_css", "value": 6143.350245274218}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 112.0, 114.0, 113.0, 125.0, 112.0, 113.0, 113.0, 117.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [166.0, 132.0, 151.0, 170.0, 135.0, 157.0, 152.0, 134.0, 176.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 163.0, 163.0, 162.0, 164.0, 169.0, 163.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 72.0, 73.0, 125.0, 73.0, 72.0, 78.0, 74.0, 94.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 138.0, 96.0, 99.0, 97.0, 142.0, 97.0, 98.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 112.0, 109.0, 109.0, 110.0, 110.0, 114.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 147.0, 150.0, 147.0, 147.0, 148.0, 147.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 70.0, 73.0, 71.0, 70.0, 71.0, 69.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 68.0, 68.0, 67.0, 68.0, 68.0, 74.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 85.0, 94.0, 93.0, 84.0, 86.0, 85.0, 85.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 125.0, 131.0, 123.0, 127.0, 119.0, 130.0, 121.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [138.0, 151.0, 148.0, 149.0, 149.0, 135.0, 149.0, 158.0, 158.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 71.0, 73.0, 71.0, 74.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1544.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [186.9158878504673], "unit": "score", "name": "DeltaBlue", "value": 353.73129999999986}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12612.5], "unit": "score", "name": "Boyer", "value": 52.84146679881068}, {"lowerIsBetter": false, "replicates": [43297.87234042553], "unit": "score", "name": "RegExp", "value": 21.0399484029484}, {"lowerIsBetter": false, "replicates": [597.0149253731344], "unit": "score", "name": "Splay", "value": 136.497425}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 20283.83161420136}]} 00:47:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20283.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1544.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6143.35"}}} 00:47:07 INFO - Return code: 0 00:47:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:47:07 INFO - # TBPL SUCCESS # 00:47:07 INFO - Running post-action listener: _resource_record_post_action 00:47:07 INFO - Running post-run listener: _resource_record_post_run 00:47:08 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 551817216; Read time: 0; Write time: 508772 00:47:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238538752; Read time: 0; Write time: 280812 00:47:08 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 313278464; Read time: 0; Write time: 227960 00:47:08 INFO - Running post-run listener: _upload_blobber_files 00:47:08 INFO - Blob upload gear active. 00:47:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:47:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:47:09 INFO - (blobuploader) - INFO - Open directory for files ... 00:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:10 INFO - (blobuploader) - INFO - Done attempting. 00:47:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:47:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:12 INFO - (blobuploader) - INFO - Done attempting. 00:47:12 INFO - (blobuploader) - INFO - Iteration through files over. 00:47:12 INFO - Return code: 0 00:47:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:47:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:47:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840e7a62df2a06b770f0c991e0dcc378e750d5d84a95fb9fb7ef575e5a43bbe01c0381a93f756c0cd95a9d0efe28f540f33ff8fb5af34669192ed8ed54fbc739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceb09bb8e67df174307213a13a833814b7c5099b6d6537631ac87f089ef65b69bb357a23670559495cc408658884c3852cfaad1d905c49aebb2367e178a37d6d"} 00:47:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:47:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:47:12 INFO - Contents: 00:47:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840e7a62df2a06b770f0c991e0dcc378e750d5d84a95fb9fb7ef575e5a43bbe01c0381a93f756c0cd95a9d0efe28f540f33ff8fb5af34669192ed8ed54fbc739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceb09bb8e67df174307213a13a833814b7c5099b6d6537631ac87f089ef65b69bb357a23670559495cc408658884c3852cfaad1d905c49aebb2367e178a37d6d"} 00:47:12 INFO - Copying logs to upload dir... 00:47:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1305.686018 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-01-11 00:47:11.835297) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 00:47:11.839203) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840e7a62df2a06b770f0c991e0dcc378e750d5d84a95fb9fb7ef575e5a43bbe01c0381a93f756c0cd95a9d0efe28f540f33ff8fb5af34669192ed8ed54fbc739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceb09bb8e67df174307213a13a833814b7c5099b6d6537631ac87f089ef65b69bb357a23670559495cc408658884c3852cfaad1d905c49aebb2367e178a37d6d"} build_url:https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/RW6TK74OS5-bunghudPGjA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840e7a62df2a06b770f0c991e0dcc378e750d5d84a95fb9fb7ef575e5a43bbe01c0381a93f756c0cd95a9d0efe28f540f33ff8fb5af34669192ed8ed54fbc739", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ceb09bb8e67df174307213a13a833814b7c5099b6d6537631ac87f089ef65b69bb357a23670559495cc408658884c3852cfaad1d905c49aebb2367e178a37d6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 00:47:11.867395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:47:11.867761) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1452499591.499783-2139456272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 00:47:11.955127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 00:47:11.955879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 00:47:11.956311) ========= ========= Total master_lag: 0.32 =========