builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1452135893.29 results: success (0) buildid: 20160106182505 builduid: 12049f2d1a944861bf41ff6404d59b0a revision: b53aa421ca199c5bf3504b74c0b80af06a69e8b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.291148) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.291571) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.291891) ========= 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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.315055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.315367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.329265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.329559) ========= 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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004742 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.378572) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.378889) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.379266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.379592) ========= 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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 19:04:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-01-06 19:04:54 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.554020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.554343) ========= 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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022482 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.605219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:53.605609) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b53aa421ca199c5bf3504b74c0b80af06a69e8b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b53aa421ca199c5bf3504b74c0b80af06a69e8b9 --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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 19:04:54,121 truncating revision to first 12 chars 2016-01-06 19:04:54,121 Setting DEBUG logging. 2016-01-06 19:04:54,121 attempt 1/10 2016-01-06 19:04:54,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b53aa421ca19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 19:04:54,461 unpacking tar archive at: b2g-inbound-b53aa421ca19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:54.230324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:54.230681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:54.238191) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:54.238578) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 19:04:54.239056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 19:04:54.239345) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:04:54 INFO - MultiFileLogger online at 20160106 19:04:54 in /builds/slave/test 19:04:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 19:04:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:04:54 INFO - {'append_to_log': False, 19:04:54 INFO - 'base_work_dir': '/builds/slave/test', 19:04:54 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 19:04:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:04:54 INFO - 'branch': 'B2G-Inbound-Non-PGO', 19:04:54 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:54 INFO - 'config_files': ('talos/linux_config.py',), 19:04:54 INFO - 'default_actions': ('clobber', 19:04:54 INFO - 'read-buildbot-config', 19:04:54 INFO - 'download-and-extract', 19:04:54 INFO - 'populate-webroot', 19:04:54 INFO - 'create-virtualenv', 19:04:54 INFO - 'install', 19:04:54 INFO - 'run-tests'), 19:04:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:54 INFO - 'download_minidump_stackwalk': True, 19:04:54 INFO - 'download_symbols': 'ondemand', 19:04:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:54 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:54 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:54 INFO - 'installer_path': 'installer.exe', 19:04:54 INFO - 'log_level': 'info', 19:04:54 INFO - 'log_name': 'talos', 19:04:54 INFO - 'log_to_console': True, 19:04:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:04:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:04:54 INFO - 'opt_config_files': (), 19:04:54 INFO - 'pip_index': False, 19:04:54 INFO - 'sps_profile': False, 19:04:54 INFO - 'sps_profile_interval': 0, 19:04:54 INFO - 'suite': 'dromaeojs', 19:04:54 INFO - 'system_bits': '32', 19:04:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:54 INFO - 'title': 'talos-linux64-ix-029', 19:04:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:54 INFO - 'use_talos_json': True, 19:04:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:04:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:54 INFO - 'work_dir': 'build'} 19:04:54 INFO - ##### 19:04:54 INFO - ##### Running clobber step. 19:04:54 INFO - ##### 19:04:54 INFO - Running pre-action listener: _resource_record_pre_action 19:04:54 INFO - Running main action method: clobber 19:04:54 INFO - rmtree: /builds/slave/test/build 19:04:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:55 INFO - Running post-action listener: _resource_record_post_action 19:04:55 INFO - ##### 19:04:55 INFO - ##### Running read-buildbot-config step. 19:04:55 INFO - ##### 19:04:55 INFO - Running pre-action listener: _resource_record_pre_action 19:04:55 INFO - Running main action method: read_buildbot_config 19:04:55 INFO - Using buildbot properties: 19:04:55 INFO - { 19:04:55 INFO - "project": "", 19:04:55 INFO - "product": "firefox", 19:04:55 INFO - "script_repo_revision": "production", 19:04:55 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:04:55 INFO - "repository": "", 19:04:55 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 19:04:55 INFO - "buildid": "20160106182505", 19:04:55 INFO - "pgo_build": "False", 19:04:55 INFO - "basedir": "/builds/slave/test", 19:04:55 INFO - "buildnumber": 3, 19:04:55 INFO - "slavename": "talos-linux64-ix-029", 19:04:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:04:55 INFO - "platform": "ubuntu64_hw", 19:04:55 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 19:04:55 INFO - "branch": "b2g-inbound", 19:04:55 INFO - "repo_path": "integration/b2g-inbound", 19:04:55 INFO - "revision": "b53aa421ca199c5bf3504b74c0b80af06a69e8b9", 19:04:55 INFO - "stage_platform": "linux64", 19:04:55 INFO - "builduid": "12049f2d1a944861bf41ff6404d59b0a", 19:04:55 INFO - "slavebuilddir": "test" 19:04:55 INFO - } 19:04:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:04:55 INFO - Running post-action listener: _resource_record_post_action 19:04:55 INFO - ##### 19:04:55 INFO - ##### Running download-and-extract step. 19:04:55 INFO - ##### 19:04:55 INFO - Running pre-action listener: _resource_record_pre_action 19:04:55 INFO - Running main action method: download_and_extract 19:04:55 INFO - mkdir: /builds/slave/test/build/tests 19:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:55 INFO - https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:04:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/test_packages.json 19:04:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/test_packages.json 19:04:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:04:57 INFO - Downloaded 1302 bytes. 19:04:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:04:57 INFO - Using the following test package requirements: 19:04:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:04:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'jsshell-linux-x86_64.zip'], 19:04:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:04:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:04:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:04:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:04:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:04:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:57 INFO - https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:04:58 INFO - Downloaded 22834677 bytes. 19:04:58 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 19:04:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:58 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 19:04:59 INFO - Return code: 0 19:04:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:59 INFO - https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:05:00 INFO - Downloaded 22834677 bytes. 19:05: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 19:05:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:05: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 19:05:02 INFO - Return code: 0 19:05: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')]} 19:05:02 INFO - https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:05:03 INFO - Downloaded 11132285 bytes. 19:05:03 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 19:05:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:05:03 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 19:05:03 INFO - Return code: 0 19:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:03 INFO - https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:05:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:05:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:05:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:05:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/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 19:05:04 INFO - Downloaded 53474935 bytes. 19:05:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:05:04 INFO - mkdir: /builds/slave/test/properties 19:05:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:04 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:04 INFO - Contents: 19:05:04 INFO - build_url:https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:05:04 INFO - Running post-action listener: _resource_record_post_action 19:05:04 INFO - Running post-action listener: set_extra_try_arguments 19:05:04 INFO - ##### 19:05:04 INFO - ##### Running populate-webroot step. 19:05:04 INFO - ##### 19:05:04 INFO - Running pre-action listener: _resource_record_pre_action 19:05:04 INFO - Running main action method: populate_webroot 19:05:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:04 INFO - '--tppagecycles', 19:05:04 INFO - '7'], 19:05:04 INFO - 'tests': ['tsvgm']}}, 19:05:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:05:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:05:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:05:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'tests': ['damp', 'tps']}, 19:05:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['damp', 'tps']}, 19:05:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:05:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:04 INFO - 'other': {'tests': ['a11yr', 19:05:04 INFO - 'ts_paint', 19:05:04 INFO - 'tpaint', 19:05:04 INFO - 'sessionrestore', 19:05:04 INFO - 'sessionrestore_no_auto_restore']}, 19:05:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['a11yr', 19:05:04 INFO - 'ts_paint', 19:05:04 INFO - 'tpaint', 19:05:04 INFO - 'sessionrestore', 19:05:04 INFO - 'sessionrestore_no_auto_restore']}, 19:05:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['a11yr', 19:05:04 INFO - 'ts_paint', 19:05:04 INFO - 'tpaint', 19:05:04 INFO - 'sessionrestore', 19:05:04 INFO - 'sessionrestore_no_auto_restore']}, 19:05:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['a11yr', 19:05:04 INFO - 'ts_paint', 19:05:04 INFO - 'tpaint', 19:05:04 INFO - 'sessionrestore', 19:05:04 INFO - 'sessionrestore_no_auto_restore']}, 19:05:04 INFO - 'other_l64': {'tests': ['a11yr', 19:05:04 INFO - 'ts_paint', 19:05:04 INFO - 'tpaint', 19:05:04 INFO - 'sessionrestore', 19:05:04 INFO - 'sessionrestore_no_auto_restore']}, 19:05:04 INFO - 'other_nol64': {'tests': ['a11yr', 19:05:04 INFO - 'ts_paint', 19:05:04 INFO - 'tpaint', 19:05:04 INFO - 'sessionrestore', 19:05:04 INFO - 'sessionrestore_no_auto_restore']}, 19:05:04 INFO - 'svgr': {'tests': ['tsvgx', 19:05:04 INFO - 'tsvgr_opacity', 19:05:04 INFO - 'tart', 19:05:04 INFO - 'tscrollx', 19:05:04 INFO - 'cart']}, 19:05:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['tsvgx', 19:05:04 INFO - 'tsvgr_opacity', 19:05:04 INFO - 'tart', 19:05:04 INFO - 'tscrollx', 19:05:04 INFO - 'cart']}, 19:05:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'tests': ['tp5o']}, 19:05:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'talos_options': ['--e10s'], 19:05:04 INFO - 'tests': ['tp5o']}, 19:05:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'talos_options': ['--xperf_path', 19:05:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:04 INFO - 'tests': ['tp5n']}, 19:05:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:05:04 INFO - 'talos_options': ['--e10s', 19:05:04 INFO - '--xperf_path', 19:05:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:04 INFO - 'tests': ['tp5n']}}, 19:05:04 INFO - 'talos.zip': {'path': '', 19:05:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:04 INFO - Running post-action listener: _resource_record_post_action 19:05:04 INFO - ##### 19:05:04 INFO - ##### Running create-virtualenv step. 19:05:04 INFO - ##### 19:05:04 INFO - Running pre-action listener: _resource_record_pre_action 19:05:04 INFO - Running main action method: create_virtualenv 19:05:04 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:04 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 19:05:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:04 INFO - Using real prefix '/usr' 19:05:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:07 INFO - Installing pip.................done. 19:05:07 INFO - Return code: 0 19:05:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:07 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:07 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 19:05:07 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 19:05:07 INFO - Using env: {'DISPLAY': ':0', 19:05:07 INFO - 'HOME': '/home/cltbld', 19:05:07 INFO - 'LANG': 'en_US.UTF-8', 19:05:07 INFO - 'LANGUAGE': 'en_US:en', 19:05:07 INFO - 'LOGNAME': 'cltbld', 19:05:07 INFO - 'MAIL': '/var/mail/cltbld', 19:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:07 INFO - 'MOZ_NO_REMOTE': '1', 19:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:07 INFO - 'NO_EM_RESTART': '1', 19:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:07 INFO - 'PWD': '/builds/slave/test', 19:05:07 INFO - 'SHELL': '/bin/bash', 19:05:07 INFO - 'SHLVL': '1', 19:05:07 INFO - 'TERM': 'linux', 19:05:07 INFO - 'TMOUT': '86400', 19:05:07 INFO - 'USER': 'cltbld', 19:05:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:07 INFO - '_': '/tools/buildbot/bin/python'} 19:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:05:07 INFO - Cleaning up... 19:05:07 INFO - Return code: 0 19:05:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:07 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:07 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 19:05:07 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 19:05:07 INFO - Using env: {'DISPLAY': ':0', 19:05:07 INFO - 'HOME': '/home/cltbld', 19:05:07 INFO - 'LANG': 'en_US.UTF-8', 19:05:07 INFO - 'LANGUAGE': 'en_US:en', 19:05:07 INFO - 'LOGNAME': 'cltbld', 19:05:07 INFO - 'MAIL': '/var/mail/cltbld', 19:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:07 INFO - 'MOZ_NO_REMOTE': '1', 19:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:07 INFO - 'NO_EM_RESTART': '1', 19:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:07 INFO - 'PWD': '/builds/slave/test', 19:05:07 INFO - 'SHELL': '/bin/bash', 19:05:07 INFO - 'SHLVL': '1', 19:05:07 INFO - 'TERM': 'linux', 19:05:07 INFO - 'TMOUT': '86400', 19:05:07 INFO - 'USER': 'cltbld', 19:05:07 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:07 INFO - '_': '/tools/buildbot/bin/python'} 19:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:07 INFO - Downloading/unpacking psutil>=0.7.1 19:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:05:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:09 INFO - Installing collected packages: psutil 19:05:09 INFO - Running setup.py install for psutil 19:05:09 INFO - building 'psutil._psutil_linux' extension 19:05:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:05:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:05:09 INFO - building 'psutil._psutil_posix' extension 19:05:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:05:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:05:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:10 INFO - Successfully installed psutil 19:05:10 INFO - Cleaning up... 19:05:10 INFO - Return code: 0 19:05:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:10 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:10 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 19:05:10 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 19:05:10 INFO - Using env: {'DISPLAY': ':0', 19:05:10 INFO - 'HOME': '/home/cltbld', 19:05:10 INFO - 'LANG': 'en_US.UTF-8', 19:05:10 INFO - 'LANGUAGE': 'en_US:en', 19:05:10 INFO - 'LOGNAME': 'cltbld', 19:05:10 INFO - 'MAIL': '/var/mail/cltbld', 19:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:10 INFO - 'MOZ_NO_REMOTE': '1', 19:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:10 INFO - 'NO_EM_RESTART': '1', 19:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:10 INFO - 'PWD': '/builds/slave/test', 19:05:10 INFO - 'SHELL': '/bin/bash', 19:05:10 INFO - 'SHLVL': '1', 19:05:10 INFO - 'TERM': 'linux', 19:05:10 INFO - 'TMOUT': '86400', 19:05:10 INFO - 'USER': 'cltbld', 19:05:10 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:10 INFO - '_': '/tools/buildbot/bin/python'} 19:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:05:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:05:12 INFO - Installing collected packages: mozsystemmonitor 19:05:12 INFO - Running setup.py install for mozsystemmonitor 19:05:12 INFO - Successfully installed mozsystemmonitor 19:05:12 INFO - Cleaning up... 19:05:12 INFO - Return code: 0 19:05:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:12 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:12 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 19:05:12 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 19:05:12 INFO - Using env: {'DISPLAY': ':0', 19:05:12 INFO - 'HOME': '/home/cltbld', 19:05:12 INFO - 'LANG': 'en_US.UTF-8', 19:05:12 INFO - 'LANGUAGE': 'en_US:en', 19:05:12 INFO - 'LOGNAME': 'cltbld', 19:05:12 INFO - 'MAIL': '/var/mail/cltbld', 19:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:12 INFO - 'MOZ_NO_REMOTE': '1', 19:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:12 INFO - 'NO_EM_RESTART': '1', 19:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:12 INFO - 'PWD': '/builds/slave/test', 19:05:12 INFO - 'SHELL': '/bin/bash', 19:05:12 INFO - 'SHLVL': '1', 19:05:12 INFO - 'TERM': 'linux', 19:05:12 INFO - 'TMOUT': '86400', 19:05:12 INFO - 'USER': 'cltbld', 19:05:12 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:12 INFO - '_': '/tools/buildbot/bin/python'} 19:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:12 INFO - Downloading/unpacking blobuploader==1.2.4 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:14 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:14 INFO - Downloading docopt-0.6.1.tar.gz 19:05:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:14 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:14 INFO - Running setup.py install for blobuploader 19:05:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:14 INFO - Running setup.py install for requests 19:05:15 INFO - Running setup.py install for docopt 19:05:15 INFO - Successfully installed blobuploader requests docopt 19:05:15 INFO - Cleaning up... 19:05:15 INFO - Return code: 0 19:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:15 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:15 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 19:05:15 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 19:05:15 INFO - Using env: {'DISPLAY': ':0', 19:05:15 INFO - 'HOME': '/home/cltbld', 19:05:15 INFO - 'LANG': 'en_US.UTF-8', 19:05:15 INFO - 'LANGUAGE': 'en_US:en', 19:05:15 INFO - 'LOGNAME': 'cltbld', 19:05:15 INFO - 'MAIL': '/var/mail/cltbld', 19:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:15 INFO - 'MOZ_NO_REMOTE': '1', 19:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:15 INFO - 'NO_EM_RESTART': '1', 19:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:15 INFO - 'PWD': '/builds/slave/test', 19:05:15 INFO - 'SHELL': '/bin/bash', 19:05:15 INFO - 'SHLVL': '1', 19:05:15 INFO - 'TERM': 'linux', 19:05:15 INFO - 'TMOUT': '86400', 19:05:15 INFO - 'USER': 'cltbld', 19:05:15 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:15 INFO - '_': '/tools/buildbot/bin/python'} 19:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:15 INFO - Running setup.py (path:/tmp/pip-g0asR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:15 INFO - Running setup.py (path:/tmp/pip-smbPl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:15 INFO - Running setup.py (path:/tmp/pip-sJkMdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:15 INFO - Running setup.py (path:/tmp/pip-F9fwV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:15 INFO - Running setup.py (path:/tmp/pip-Eo6Hpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:16 INFO - Running setup.py (path:/tmp/pip-SJf2Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:16 INFO - Running setup.py (path:/tmp/pip-c6C64S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:16 INFO - Running setup.py (path:/tmp/pip-ZrZF5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:16 INFO - Running setup.py (path:/tmp/pip-Hgr9vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:16 INFO - Running setup.py (path:/tmp/pip-JNLCVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:16 INFO - Running setup.py (path:/tmp/pip-HmyIuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:16 INFO - Running setup.py (path:/tmp/pip-MYp0vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:16 INFO - Running setup.py (path:/tmp/pip-R_qN0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:16 INFO - Running setup.py (path:/tmp/pip-O_cUj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:16 INFO - Running setup.py (path:/tmp/pip-3grBGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:16 INFO - Running setup.py (path:/tmp/pip-6XfuIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:16 INFO - Running setup.py (path:/tmp/pip-t4II54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:16 INFO - Running setup.py install for manifestparser 19:05:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:16 INFO - Running setup.py install for mozcrash 19:05:17 INFO - Running setup.py install for mozdebug 19:05:17 INFO - Running setup.py install for mozdevice 19:05:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Running setup.py install for mozfile 19:05:17 INFO - Running setup.py install for mozhttpd 19:05:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Running setup.py install for mozinfo 19:05:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Running setup.py install for mozInstall 19:05:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Running setup.py install for mozleak 19:05:17 INFO - Running setup.py install for mozlog 19:05:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Running setup.py install for moznetwork 19:05:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:17 INFO - Running setup.py install for mozprocess 19:05:18 INFO - Running setup.py install for mozprofile 19:05:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:18 INFO - Running setup.py install for mozrunner 19:05:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:18 INFO - Running setup.py install for mozscreenshot 19:05:18 INFO - Running setup.py install for moztest 19:05:18 INFO - Running setup.py install for mozversion 19:05:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:18 INFO - Cleaning up... 19:05:18 INFO - Return code: 0 19:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:18 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:18 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 19:05:18 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 19:05:18 INFO - Using env: {'DISPLAY': ':0', 19:05:18 INFO - 'HOME': '/home/cltbld', 19:05:18 INFO - 'LANG': 'en_US.UTF-8', 19:05:18 INFO - 'LANGUAGE': 'en_US:en', 19:05:18 INFO - 'LOGNAME': 'cltbld', 19:05:18 INFO - 'MAIL': '/var/mail/cltbld', 19:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:18 INFO - 'MOZ_NO_REMOTE': '1', 19:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:18 INFO - 'NO_EM_RESTART': '1', 19:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:18 INFO - 'PWD': '/builds/slave/test', 19:05:18 INFO - 'SHELL': '/bin/bash', 19:05:18 INFO - 'SHLVL': '1', 19:05:18 INFO - 'TERM': 'linux', 19:05:18 INFO - 'TMOUT': '86400', 19:05:18 INFO - 'USER': 'cltbld', 19:05:18 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:18 INFO - '_': '/tools/buildbot/bin/python'} 19:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:18 INFO - Running setup.py (path:/tmp/pip-ZVqolj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:18 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)) 19:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:18 INFO - Running setup.py (path:/tmp/pip-VcYTZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:19 INFO - Running setup.py (path:/tmp/pip-JqcEdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:19 INFO - Running setup.py (path:/tmp/pip-gc6zEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:19 INFO - Running setup.py (path:/tmp/pip-WD0X2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:19 INFO - Running setup.py (path:/tmp/pip-gG_K3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:19 INFO - Running setup.py (path:/tmp/pip-kdLEoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:19 INFO - Running setup.py (path:/tmp/pip-rLPJxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:19 INFO - Running setup.py (path:/tmp/pip-RBDjaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:19 INFO - Running setup.py (path:/tmp/pip-Y7feUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:19 INFO - Running setup.py (path:/tmp/pip-3lm1Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:19 INFO - Running setup.py (path:/tmp/pip-R1vcXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:19 INFO - Running setup.py (path:/tmp/pip-VqqfMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:19 INFO - Running setup.py (path:/tmp/pip-Fl0wQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:19 INFO - Running setup.py (path:/tmp/pip-plVwYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:19 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)) 19:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:19 INFO - Running setup.py (path:/tmp/pip-yFCycy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:20 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)) 19:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:20 INFO - Running setup.py (path:/tmp/pip-hmm7zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:20 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)) 19:05:20 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)) 19:05:20 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)) 19:05:20 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)) 19:05:20 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)) 19:05:20 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)) 19:05:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:22 INFO - Downloading blessings-1.5.1.tar.gz 19:05:22 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 19:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:22 INFO - Installing collected packages: blessings 19:05:22 INFO - Running setup.py install for blessings 19:05:22 INFO - Successfully installed blessings 19:05:22 INFO - Cleaning up... 19:05:22 INFO - Return code: 0 19:05:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:22 INFO - Reading from file tmpfile_stdout 19:05:22 INFO - Current package versions: 19:05:22 INFO - argparse == 1.2.1 19:05:22 INFO - blessings == 1.5.1 19:05:22 INFO - blobuploader == 1.2.4 19:05:22 INFO - docopt == 0.6.1 19:05:22 INFO - manifestparser == 1.1 19:05:22 INFO - mozInstall == 1.12 19:05:22 INFO - mozcrash == 0.16 19:05:22 INFO - mozdebug == 0.1 19:05:22 INFO - mozdevice == 0.47 19:05:22 INFO - mozfile == 1.2 19:05:22 INFO - mozhttpd == 0.7 19:05:22 INFO - mozinfo == 0.9 19:05:22 INFO - mozleak == 0.1 19:05:22 INFO - mozlog == 3.1 19:05:22 INFO - moznetwork == 0.27 19:05:22 INFO - mozprocess == 0.22 19:05:22 INFO - mozprofile == 0.28 19:05:22 INFO - mozrunner == 6.11 19:05:22 INFO - mozscreenshot == 0.1 19:05:22 INFO - mozsystemmonitor == 0.0 19:05:22 INFO - moztest == 0.7 19:05:22 INFO - mozversion == 1.4 19:05:22 INFO - psutil == 3.1.1 19:05:22 INFO - requests == 1.2.3 19:05:22 INFO - wsgiref == 0.1.2 19:05:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:22 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:22 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 19:05:22 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 19:05:22 INFO - Using env: {'DISPLAY': ':0', 19:05:22 INFO - 'HOME': '/home/cltbld', 19:05:22 INFO - 'LANG': 'en_US.UTF-8', 19:05:22 INFO - 'LANGUAGE': 'en_US:en', 19:05:22 INFO - 'LOGNAME': 'cltbld', 19:05:22 INFO - 'MAIL': '/var/mail/cltbld', 19:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:22 INFO - 'MOZ_NO_REMOTE': '1', 19:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:22 INFO - 'NO_EM_RESTART': '1', 19:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:22 INFO - 'PWD': '/builds/slave/test', 19:05:22 INFO - 'SHELL': '/bin/bash', 19:05:22 INFO - 'SHLVL': '1', 19:05:22 INFO - 'TERM': 'linux', 19:05:22 INFO - 'TMOUT': '86400', 19:05:22 INFO - 'USER': 'cltbld', 19:05:22 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:22 INFO - '_': '/tools/buildbot/bin/python'} 19:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 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)) 19:05:22 INFO - Cleaning up... 19:05:22 INFO - Return code: 0 19:05:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:22 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:22 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 19:05:22 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 19:05:22 INFO - Using env: {'DISPLAY': ':0', 19:05:22 INFO - 'HOME': '/home/cltbld', 19:05:22 INFO - 'LANG': 'en_US.UTF-8', 19:05:22 INFO - 'LANGUAGE': 'en_US:en', 19:05:22 INFO - 'LOGNAME': 'cltbld', 19:05:22 INFO - 'MAIL': '/var/mail/cltbld', 19:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:22 INFO - 'MOZ_NO_REMOTE': '1', 19:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:22 INFO - 'NO_EM_RESTART': '1', 19:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:22 INFO - 'PWD': '/builds/slave/test', 19:05:22 INFO - 'SHELL': '/bin/bash', 19:05:22 INFO - 'SHLVL': '1', 19:05:22 INFO - 'TERM': 'linux', 19:05:22 INFO - 'TMOUT': '86400', 19:05:22 INFO - 'USER': 'cltbld', 19:05:22 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:22 INFO - '_': '/tools/buildbot/bin/python'} 19:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:22 INFO - Downloading/unpacking jsonschema 19:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:24 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 19:05:24 INFO - Downloading/unpacking functools32 (from jsonschema) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:24 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:24 INFO - warning: no files found matching '*.txt' 19:05:24 INFO - no previously-included directories found matching 'build' 19:05:24 INFO - no previously-included directories found matching 'dist' 19:05:24 INFO - no previously-included directories found matching '.git*' 19:05:24 INFO - Installing collected packages: jsonschema, functools32 19:05:24 INFO - Running setup.py install for functools32 19:05:25 INFO - warning: no files found matching '*.txt' 19:05:25 INFO - no previously-included directories found matching 'build' 19:05:25 INFO - no previously-included directories found matching 'dist' 19:05:25 INFO - no previously-included directories found matching '.git*' 19:05:25 INFO - Successfully installed jsonschema functools32 19:05:25 INFO - Cleaning up... 19:05:25 INFO - Return code: 0 19:05:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:25 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 0x7f59da6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, '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': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', '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 19:05:25 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 19:05:25 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 19:05:25 INFO - Using env: {'DISPLAY': ':0', 19:05:25 INFO - 'HOME': '/home/cltbld', 19:05:25 INFO - 'LANG': 'en_US.UTF-8', 19:05:25 INFO - 'LANGUAGE': 'en_US:en', 19:05:25 INFO - 'LOGNAME': 'cltbld', 19:05:25 INFO - 'MAIL': '/var/mail/cltbld', 19:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:25 INFO - 'MOZ_NO_REMOTE': '1', 19:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:25 INFO - 'NO_EM_RESTART': '1', 19:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:25 INFO - 'PWD': '/builds/slave/test', 19:05:25 INFO - 'SHELL': '/bin/bash', 19:05:25 INFO - 'SHLVL': '1', 19:05:25 INFO - 'TERM': 'linux', 19:05:25 INFO - 'TMOUT': '86400', 19:05:25 INFO - 'USER': 'cltbld', 19:05:25 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:25 INFO - '_': '/tools/buildbot/bin/python'} 19:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:25 INFO - Downloading/unpacking flake8 19:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:05:27 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 19:05:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:05:27 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 19:05:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:27 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 19:05:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:05:27 INFO - no previously-included directories found matching 'docs/_build' 19:05:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:05:27 INFO - Running setup.py install for pep8 19:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:05:27 INFO - no previously-included directories found matching 'docs/_build' 19:05:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:05:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:05:27 INFO - Cleaning up... 19:05:27 INFO - Return code: 0 19:05:27 INFO - Running post-action listener: _resource_record_post_action 19:05:27 INFO - Running post-action listener: _start_resource_monitoring 19:05:27 INFO - Starting resource monitoring. 19:05:27 INFO - ##### 19:05:27 INFO - ##### Running install step. 19:05:27 INFO - ##### 19:05:27 INFO - Running pre-action listener: _resource_record_pre_action 19:05:27 INFO - Running main action method: install 19:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:28 INFO - Reading from file tmpfile_stdout 19:05:28 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:28 INFO - Reading from file tmpfile_stdout 19:05:28 INFO - Output received: 19:05:28 INFO - Usage: mozinstall [options] installer 19:05:28 INFO - Options: 19:05:28 INFO - -h, --help show this help message and exit 19:05:28 INFO - -d DEST, --destination=DEST 19:05:28 INFO - Directory to install application into. [default: 19:05:28 INFO - "/builds/slave/test"] 19:05:28 INFO - --app=APP Application being installed. [default: firefox] 19:05:28 INFO - mkdir: /builds/slave/test/build/application 19:05:28 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'] 19:05:28 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 19:05:43 INFO - Reading from file tmpfile_stdout 19:05:43 INFO - Output received: 19:05:43 INFO - /builds/slave/test/build/application/firefox/firefox 19:05:43 INFO - Running post-action listener: _resource_record_post_action 19:05:43 INFO - ##### 19:05:43 INFO - ##### Running run-tests step. 19:05:43 INFO - ##### 19:05:43 INFO - Running pre-action listener: _resource_record_pre_action 19:05:43 INFO - Running main action method: run_tests 19:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:43 INFO - Python 2.7.3 19:05:43 INFO - Return code: 0 19:05:43 INFO - grabbing minidump binary from tooltool 19:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:43 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 0x22693d0>, '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 0x21d4ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d5360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:43 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 19:05:43 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 19:05:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:43 INFO - Return code: 0 19:05:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:05:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:05:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:05:44 INFO - Return code: 0 19:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:05:44 INFO - Using env: {'DISPLAY': ':0', 19:05:44 INFO - 'HOME': '/home/cltbld', 19:05:44 INFO - 'LANG': 'en_US.UTF-8', 19:05:44 INFO - 'LANGUAGE': 'en_US:en', 19:05:44 INFO - 'LOGNAME': 'cltbld', 19:05:44 INFO - 'MAIL': '/var/mail/cltbld', 19:05:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:44 INFO - 'MOZ_NO_REMOTE': '1', 19:05:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:44 INFO - 'NO_EM_RESTART': '1', 19:05:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:44 INFO - 'PWD': '/builds/slave/test', 19:05:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:44 INFO - 'SHELL': '/bin/bash', 19:05:44 INFO - 'SHLVL': '1', 19:05:44 INFO - 'TERM': 'linux', 19:05:44 INFO - 'TMOUT': '86400', 19:05:44 INFO - 'USER': 'cltbld', 19:05:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270', 19:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:44 INFO - '_': '/tools/buildbot/bin/python'} 19:05:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:05:45 INFO - mozversion application_buildid: 20160106182505 19:05:45 INFO - mozversion application_changeset: b53aa421ca199c5bf3504b74c0b80af06a69e8b9 19:05:45 INFO - mozversion application_display_name: Nightly 19:05:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:45 INFO - mozversion application_name: Firefox 19:05:45 INFO - mozversion application_remotingname: firefox 19:05:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:05:45 INFO - mozversion application_vendor: Mozilla 19:05:45 INFO - mozversion application_version: 46.0a1 19:05:45 INFO - mozversion platform_buildid: 20160106182505 19:05:45 INFO - mozversion platform_changeset: b53aa421ca199c5bf3504b74c0b80af06a69e8b9 19:05:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:05:45 INFO - mozversion platform_version: 46.0a1 19:05:45 INFO - using testdate: 1452135945 19:05:45 INFO - actual date: 1452135945 19:05:45 INFO - starting webserver on 'localhost:40209' 19:05:45 INFO - SUITE-START | Running 3 tests 19:05:45 INFO - TEST-START | dromaeo_css 19:05:45 INFO - operating with platform_type : linux_ 19:05:45 INFO - Initialising browser for dromaeo_css test... 19:05:45 INFO - TEST-INFO | started process 2235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiQtBvU/profile http://localhost:40209/getInfo.html) 19:05:49 INFO - PROCESS | 2235 | __metrics Screen width/height:1600/1200 19:05:49 INFO - PROCESS | 2235 | colorDepth:24 19:05:49 INFO - PROCESS | 2235 | Browser inner width/height: 1024/697 19:05:49 INFO - PROCESS | 2235 | __metrics 19:05:49 INFO - PROCESS | 2235 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:05:49 INFO - PROCESS | 2235 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:05:49 INFO - PROCESS | 2235 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:05:50 INFO - TEST-INFO | 2235: exit 0 19:05:50 INFO - Browser initialized. 19:05:50 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:50 INFO - TEST-INFO | started process 2328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiQtBvU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:02 INFO - PROCESS | 2328 | RSS: Main: 147169280 19:06:02 INFO - PROCESS | 2328 | 19:06:53 INFO - PROCESS | 2328 | 1452136013315 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] 19:09:05 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:40209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40209/tests/dromaeo/cssquery-ext.html) 19:09:06 INFO - PROCESS | 2328 | RSS: Main: 265850880 19:09:06 INFO - PROCESS | 2328 | 19:12:09 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:40209/tests/dromaeo/cssquery-ext.html (next: http://localhost:40209/tests/dromaeo/cssquery-jquery.html) 19:12:09 INFO - PROCESS | 2328 | RSS: Main: 224018432 19:12:09 INFO - PROCESS | 2328 | 19:15:11 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:40209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40209/tests/dromaeo/cssquery-mootools.html) 19:15:12 INFO - PROCESS | 2328 | RSS: Main: 220069888 19:15:12 INFO - PROCESS | 2328 | 19:18:14 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:40209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40209/tests/dromaeo/cssquery-prototype.html) 19:18:14 INFO - PROCESS | 2328 | RSS: Main: 207634432 19:18:14 INFO - PROCESS | 2328 | 19:21:17 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:40209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40209/tests/dromaeo/cssquery-yui.html) 19:21:18 INFO - PROCESS | 2328 | RSS: Main: 210132992 19:21:18 INFO - PROCESS | 2328 | 19:24:20 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:40209/tests/dromaeo/cssquery-yui.html (next: http://localhost:40209/tests/dromaeo/cssquery-dojo.html) 19:24:21 INFO - PROCESS | 2328 | RSS: Main: 257830912 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | __start_tp_report 19:24:21 INFO - PROCESS | 2328 | _x_x_mozilla_page_load 19:24:21 INFO - PROCESS | 2328 | _x_x_mozilla_page_load_details 19:24:21 INFO - PROCESS | 2328 | |i|pagename|runs| 19:24:21 INFO - PROCESS | 2328 | |0;dojo.html;2579.4841031793644;2689.327668082978;2691.2329985953984;2704.9864750676243;2714.1721774858665;4499.595036446719;4635.049814787969;4657.720536767796;4662.160811054009;4667.136579732747;4611.769411529419;4613.423322084739;4652.46496652885;4669.929951050737;4677.415323084614;4209.579042095781;4264.189803937242;4281.614654681086;4328.740275583459;4357.085012147453;4065.5324637666604;4305.052888364555;4313.676474264427;4356.934645980297;4389.802458889341;4114.321137012389;4158.729682570638;4183.372494125875;4297.935530967038;4313.82744690212;4254.936175957363;4259.254630439692;4273.594008569181;4290.206311832289;4294.398784170187;4043.4541336919433;4241.130568233536;4258.105797782469;4262.360645903108;4298.570142985708;4546;4558.61251793598;4570.063137056895;4584.931226031612;4584.977075114636;4894;4897.461279259314;4975.776090075955;4976.726280054596;5015.072211640858;5004.074246264453;5022.598192144656;5033.219850923113;5069.290299358093;5075.111855425286;4437.489688685778;4555.043440877453;4649.604783593399;4667.836625718083;4703.64722645803;4955.752212389366;5038;5172.508611681884;5175.120229560984;5175.146100893386;4882.6826256293225;4887.266909963463;4889.242167464049;4890.437599676012;4937.802487900515;4766.856994290177;4886.804527818918;4974.27872958419;4976.975115124474;4982.701037937735;4776.522347765195;4892.0705066037335;4976.5023497649945;4980.327655766498;4981.341145638719;4900.705957642553;4912.410510738663;4917.557419832232;4923.163062279421;4964.15609346412;3988.521377434726;4087.8364865405647;4162;4174.895627609334;4223.345381465878;3567.250877315793;3571.5714114306447;3630.983324669097;3659.3596120678776;3690.391085470921;4334.761588112621;4340.30555111187;4341.609255166987;4342.305231163062;4382.101669157815;4811.158047341702;5000.874978125576;5016.02187573427;5016.247562865599;5017.648764586517;4214.936775948363;4220.957790422118;4222.239996800606;4265.445492086009;4347.413099231627;4434.423524941737;4446.666500012512;4448.733076015449;4479.484859241164;4483.574060464251;4762.499937506581;4768.737719425465;4769.833055843098;4777.116233496675;4819.59033482158;4761.2382018876815;4887.584555312696;4887.975560122177;4990.126727822689;5001.149804533311;4615.838445654386;4636.536346365337;4638.512956139557;4659.114768194032;4741.881452963704;4908.680935739166;4937.530934561211;4946;4988.551030407136;4990.8003679853855;5014.899702006012;5021.3472248608905;5022.271770593316;5028.64799464034;5061.164907790173;4606.56237657422;4728.71627702339;4745.667803253739;4806.975965120152;4868.805247790048;4825.10735513931;4848.781804818721;4854.077725232195;4876.780544875418;4897.559219670246;4737.099951009297;4761.547652972962;4763.618910487084;4768.380110585602;4813.085513752376;4651.395318608695;4710.293455981493;4755.952440475551;4765.0946320199055;4870.342503761947;4775.952240477551;4790.8323208687525;4796.880077998078;4807.663463557517;4822.397200349957 19:24:21 INFO - PROCESS | 2328 | |1;ext.html;488.73608251544147;521.8877941242632;526.3709866709281;544.3196004993757;547.6768706463189;24996.125135620256;32832.83583582082;33161.66838331619;33174.17064573381;33185.502217466696;35991;36612.81693591528;36684;36713.816430917876;36725;6851.862962740742;6963.582185068912;7569.545827250369;7793.2596403341595;7796.6491507882;9842.114209721123;10091.949540252324;10092.596296148145;10093.343932644355;10096.69709908704;9754.317197796121;9793.26550508711;9878.555465004092;9884.802303953917;9886.90113098867;9782.364146330467;9882.258830587734;9885;9890.258230632731;9893.703188904381;9620.567074481665;9767.951160244224;9769.462679552622;10103.696889093339;10104.191664666883;36014;36580.26839463222;36752.26495470102;36810;36851;2955.246412164884;2966.1991262359256;2969.503606110234;3017.7585793136495;3610.855565777366;28359.57460638092;28372.574411383845;28529.429411411656;28779.985401021935;29181.70818291811;3383.6278009418943;3470.8438120284395;3476.6001909780193;3553.987113672591;3577.964220357815;235599;235688;236001;236299;236499;46681;55648.72175639096;55998.440015600136;56073.43926560764;56092.719536402874;46098.53901460942;58459.70770146207;59881.910037647285;59969.70015149896;60022.79954400888;14268.14391136535;14547.927260363631;14663.633409164857;14671.193084380462;14707.485238016618;9412.388194767318;9533.237341012702;10480.947595261974;10641.414722190353;11040.116790656728;18285.63428731418;18669.43991680252;18707.75506939149;18730.1571429286;18762.249510019446;7458.813529661693;7586.734464293723;7674.429066262753;7701.653425595861;7776.339011184;808.7412028151053;817.1297568089965;889.2707979456783;891.6567121658079;921.824853277875;22943.655845162335;23331;23419;23422.297331080095;23425.88287058588;909.9545022748836;921.2491819167357;955.8709574207393;957.1720461800493;1014.5688082564881;12273.938630306791;12731;12758.48966041348;12775.552855650008;12803.35983200855;264001;268326;270371;270526;272033.1568500989;44448.11103777906;44867.32699009518;44888;44902.77548612236;45034.77482612631;1188.6255829413708;1203.867574566797;1211.4548453196096;1430.4278288684402;1430.6351880270672;23842.3428822565;24398.390040249134;24697.5277484869;24790.628140577544;24857.751422485544;37020.074498137765;37277.440838387985;37341.06647333838;37361.25277494381;37362.8131859339;235524;258820;260406;260491;261348;22348.664770028787;28472.572911406758;28980.42039159163;29160.125196244146;29408.852955735085;33220.667793322726;38893.416598750475;39126.6087339123;39964.40053399259;40144.1971160581;28846.423071538033;32042.679573203968;33481.33037339191;33841.32317353688;34265;28435.92030924786;32277.193070173435;32978.17554561155;33303.864423033934;37004.629953701195;32349.514757279132;32926.17684557905;32933;33156.66843331536;33242;28518.57222141628;29060.85814360794;29336;29429.85285073561;29701.257468563457;22838.429039273487;23382.415439614146;23781.52436951286;24180.274591762274;24403.877980609985 19:24:21 INFO - PROCESS | 2328 | |2;jquery.html;326.6554820882265;327.97212236959865;328.09936723693465;330.0922463226128;332.7720511449657;12389.19470234434;12765.23408595485;14698.926505367472;15178.2410879456;15198.240087995597;12731.745365092693;14359.641008974755;15841.603959901007;16679.24943377548;16743.748843767324;4837.298591704201;4858.902821943559;4980.750962451881;4989.126902792015;4990.75046247688;3701.463287823264;3828.3109040372724;4949.975250123744;5009.799608015675;5559.166125081229;5628.746706398222;5662.801801936933;5685.317761868581;5685.45988131129;5688.544916406678;5519.282493275869;5645.125005624135;5793.7392817323325;5800.8259752207505;5801.564882633819;5051.343325367716;5070.543651071422;5082.263071854561;5085.847424577269;5088.363954505687;17444.389446369318;19080.427587172268;19351.12919918607;19477.12352944121;19656.213751449926;1794.6231291428815;1797.4607617714632;1799.5411170151528;1925.3838771593096;1926.412444204517;12475.50097996079;12485.50057997679;12714.61856144317;12834.294113823737;12865.228086314852;1656.5527307626994;1697.6265221651217;1705.9914700426418;1742.7298768690746;1764.2325588369101;48492.272615910435;55691.44308556903;58084.44902162734;58303;58819.41180588182;9742.659006934724;9743.464109474047;9744.805103898025;9764.609415623296;9805.989772096704;12494.875051249554;12529.624111276677;12544.937275313565;12551.811722823983;12574.30841303737;7106.680199391039;7152.105986751656;7179.461540384492;7264.34620884123;7346.375558077516;6876.484263680244;6883.862322753517;6891.724331026803;6993.0908981832035;7027.15674119109;4108.623611090258;4115.36211887158;4139.399787030924;4170.91658166841;4173.144505376391;1601.6476375197437;1623.6427985843095;1631.1354981859633;1679.177203170462;1684.3683618643008;817.5340056168046;921.6405601815297;921.709661456639;942.2838642631513;982.4301904895144;15371.461998830211;15659.37362505487;15780.68438631221;16222.756658650129;16226.837731622532;790.7904405332591;834.1366685480499;858.4420126917554;861.7199410191713;920.2637889688223;8006.519608823489;8401.411901166983;8418.957905210556;8428.704995325133;8582.356323275779;469021;475273;477420;477819;483732;69224.6538767303;69301.65349173221;69522.65238673876;69783.65108174528;71049.2895071053;1049.1187402581868;1050.2700623067049;1052.2055847834836;1098.181854518389;1103.178132291448;13136.868631313564;13199.472021119047;13418.530351437652;13486;13544.86455135436;29266.561001584567;29469.55795663024;30085;30184;30232.697673022987;39876;42310.153796923274;42319.36520952127;42548.78725606352;43734.56265437432;8866.689665861664;8917.42036767608;8949.776255593662;9020.233280171258;9034.819303614022;12293.44679489443;15914.124723140338;16571.585710357336;16644.417445389354;16666.50000499987;13683.657908552366;13786.172829630254;14061.859381406055;14089.225092619594;14105.647358816112;12118.878811211775;13267.535636252685;13268.13757105785;13876.514321998682;14113.717725645225;10582.417967011581;10931.289466184673;13160;13431.798523022358;13673.111247768864;8424.536650484282;8633.525156116473;8874.778130546789;8899.955500222457;8915.37592368528;9086.409383390059;9186.770330741518;9559.426434413957;13358.131721438076;13399.933000334935 19:24:21 INFO - PROCESS | 2328 | |3;mootools.html;1220.2251570252886;1393.1014495650306;1398.8321401431826;1517.5295658345913;1730.7057800173968;6013.27840659121;6577.50668699847;6666.13340265766;6670.76652317169;6682.398584127428;6651.501137414689;6796.626185559805;6820.11338525991;6821.761238356658;6824.692888820003;1692.678391105686;1719.5787032177134;1721.2254485481521;2040.8367330613553;2091.5294058836794;2048.057893369052;2072.5336799220204;2081.157131361801;2084.760252570951;2085.092984551725;2029.6853987631941;2033.4001469566513;2038.1134206620093;2084.4893001214723;2084.5414008918015;2020.7069974853564;2060.649689552772;2081.479630092477;2092.194505115534;2100.0654708654656;2070.7989366167585;2104.095239047209;2110.2192188890053;2119.692644566529;2121.8302535797097;6969.825754356131;6986;7000.9649951750425;7015.47383946201;7045.823854403681;4090.1001779608737;4168.979155104205;4170.35359519275;4182.954261434641;4185.97907010466;2564.5640241158862;2626.0283695032767;2626.737326267358;2638.103044964702;2640.854752988585;789.9763007109796;803.3974519110667;825.3892119831341;836.4521238588734;837.8659414493712;9405;9415.199708024826;9415.387999780061;9431.245500359955;9433.103855133751;3562.091666624994;3597;3667.7065834733157;3676.0809797550614;3690.095926498025;8139;8151.470154439942;8165.101838797727;8168.714095006646;8169.305609023299;4046.77742724153;4051.088505086332;4063.227986682521;4072.3484242521645;4073.042834933788;3677.687396571268;3689.7417180797624;3691.0218792020137;3693.612170722089;3695.593484716679;2925.093221101465;2978.955315670267;3207.919802004922;3357.278185190196;3363.680450357212;1000.2448151645607;1002.9348092373972;1003.9698809035741;1007.123802291996;1007.5566750629699;862.2283056664376;864.6238886084574;869.5261082709939;902.0979020979021;923.4782347973373;6609.1077704510235;6641.86716265672;6645.800625981132;6652.866942661217;6688.3646053624825;1021.1473419694489;1046.534292239946;1050.0811789684026;1051.4847724614883;1077.7251800790905;5222.138347172674;5264.157734762496;5264.526192642604;5265.157574788015;5270.420253772082;7979.321757650665;8154.306883914815;8171.9182808172345;8347.248747612623;8432.704855330034;7980.481268717631;7997.240262175084;8059.032916050111;8081.3130883874355;8098.838023239502;6410.038494225811;6566.4418524425955;6611.603303801788;6639.634820084845;6640.900386494206;6631.701573429111;6694.062831203538;6695.397414232742;6697.665116744241;6703.195616526048;7155.356017958408;7370.889436658562;7404.037475128199;7623.69505219785;7649.847003059796;7333.230010848784;7431.628418579157;7508.136564295176;7754.185810490043;7846.843063138819;6166.784162554289;6255.874882502416;6267.780627678009;6272;6281.057841323838;6491.4482269005775;6625.271220165874;6654.401103900672;6694;6695.7321707133115;6122.785702500391;6216.44052035319;6218.22272215973;6241.251049874044;6278.152449419453;6110.480609148094;6140.631562106288;6247.437730604267;6298.275698294571;6302.5588208826775;5992.730327135202;6089.056196289582;6134.325224225242;6135.294441139147;6142.846428839315;5667.914981275367;5681.857953551194;5690.2887139107615;5692.971535142297;5704.971475142598;5634.267545219095;5640.32316122068;5643.915341269802;5659.773609055756;5670.659760414388 19:24:21 INFO - PROCESS | 2328 | |4;prototype.html;292.3247298739911;295.7707776473233;300.2493765586035;301.74502545349185;301.82494153391036;5248.973755131219;5275.235090911816;5315.548178404835;5351.411344752084;5355.277037599928;5241;5350.438203988583;5362.570994320455;5364;5371.57027437805;4147.8963025924295;4150.667946564267;4151.937720934188;4156.106437116019;4158.8544400945975;3927.253821773868;4013.8996525086814;4019.477467929165;4019.638232559069;4136.648384887289;4081.469408976829;4083.6528895043957;4084.4690190275373;4107.1580326033245;4107.712460127792;4087.0395457067716;4091.734037287567;4098.385242213662;4101.343784994401;4110.527289361732;3566.857325706969;3588.856445742167;3591.0304217861294;3597.460380942853;3599.3881040222964;5009.924851127236;5151.922721159186;5162.1224391853475;5163.122269214205;5200.739963001873;4749.762511874427;4756.7145971241835;4759.190937540592;4760.33355330254;4763.071201115784;5672.5178359839465;5673.063944449161;5679.261695979538;5683.630564013367;5696.743646535916;3684.0237337105686;3769.604191559874;3776.131489757344;3841.5582208046153;3848.807559622008;5850.210221620069;5882.117682347639;5889.204957330749;5907.113932910098;5908.704564771744;4009.0779120801794;4010.137820368635;4016.477857878457;4016.59834016596;4016.758994460342;4065.8576949807207;4067.654249388835;4072.7963601819793;4078.1028173801715;4079.326911059642;4531.799073245593;4653.697509661861;4661.627069834405;4662.090892275974;4706.388169537938;5629.746661400247;5632;5635.380108188096;5638.971805140948;5657.9434205658235;1423.6939058102557;1443.8483959184343;1444.4655477473402;1447.6453268949174;1448.2324368084933;949.084133810862;959.4195511715451;969.9903000970041;975.5805003848271;976.9413835169912;4989.226669866177;4998.125328067574;5001.374828146481;5007.3240112584335;5010;5863.70681465925;5865.149553314745;5869.119632055226;5871.882562348815;5871.94128058714;4957.206846904478;4994.650374473752;4994.875128121754;4996.475370086088;5004.699718016931;3066.1874603230162;3132.6554079051284;3151.952720709191;3162.667919868427;3163.813569911283;5532.419095994943;5561.944380556223;5604.41153678866;5609.943900561024;5614.29821272341;6063.696815159225;6068.908966365508;6069.332373438918;6070.666113363719;6072.967595508774;5587.944120558743;5592.384837667934;5600.635958662674;5603.607747457639;5606.579506537026;5720.771169153354;5912.763489460373;5920;5932.080527518242;5933.347331793586;5476.835694929158;5585.944140558542;5697.23087383198;5773.191753154478;5793.478586927196;5599.776008959759;5614.354349249888;5617.837132703857;5625.46558076982;5629.3244810621345;4028.4762980812307;4058.6347228749555;4060.0661847774586;4064.4106604541585;4064.6138616831354;5669.574781891292;5869.4717475427415;5885.911711324419;5894.970525147347;5902.2622172228475;5666.405027472056;5681;5687.402822703557;5687.658740475585;5713.771449141987;5688.800891968761;5694.259746232963;5696.515796157208;5698.800541981011;5707.514861236841;5596.944030559643;5597.888042239214;5598.216249725123;5602.187682785891;5607.243022191952;5546.889062218814;5684.033714268667;5743.310802703702;5760.481556659921;5764.48119669215;5577.637453565505;5582.33012038558;5584.720763961867;5589.636673616202;5590.7763689453595 19:24:21 INFO - PROCESS | 2328 | |5;yui.html;689.090400671114;715.470551791674;729.9963500182502;758.8292634157314;790.1505881177735;10783.191260655452;10938.945305273472;10944.726381840457;10945.726356841064;10961.945190274047;10335.638252661158;10425.218108641844;10495.73760655982;10500.107490863267;10501.002404771554;614.8032629558543;622.7540121651945;788.9881651775228;793.5238856685971;809.4778867630375;804.4610111225493;807.1000834070028;809.955452450115;810.781089105944;812.0417906869891;832.7585000349891;841.3185319890878;842.2588122452233;842.3050982939069;842.9915700842975;639.5682914033032;647.7894684227622;830.3979614779267;845.4969293270556;849.5964416901923;626.2141013028665;630.552307861419;631.1227393922452;631.1384959530208;631.5200447659765;10704.19718521114;10827.512761925653;10848;10856.837147442795;10879.782404351949;10085.193184545218;10725.30285531438;10801.243912926098;11082.944585277022;11226.719332016683;9048.683296084671;9064.138906803842;9076.693192480108;9227.630894764201;9341.719748407559;3234.4339740545547;3243.189202699325;3260.0708797992697;3277.2626159114247;3311.6522765109557;38458.42312365317;38658;38774;39306.803465982775;39473;8914.509701966454;8943.195112439911;8971.685990990414;9007.909920900838;9074.364794464323;16724.749128762836;16759;16780.748288775678;16804.579885502717;16846.220373638458;5754.251947246831;6072.51419886408;6088.573799833969;6113.694315284218;6213.285472170758;3405.5743032120986;3478.826058697055;3527.470879368064;3541.3979623464074;3621.27574485104;2611.360216746871;2871.0956048844546;2941.3087924337765;2948.2334593005544;2949.705029497076;500.9624278179151;509.09381301283776;510.21427002416607;514.4932241741881;518.1683398145997;448.8586095379945;461.7945014468529;464.4728233455053;563.2790028763189;590.2415396215843;7612.923870761332;7629.046369203849;7643.770686879402;7673.386129109658;7718.151003389623;495.89090400111917;554.2462251338177;567.9943200568024;572.1732097119706;622.7197761007474;3626.8367923443507;3707.3697471429923;3741.9251614967548;3771.5097037385513;3810.2950954073585;48711.51288487141;49519;49953.25070123951;50271.74864125729;50359.24461133086;45030.549694503294;45033;45355.77322113435;45543.77228113905;46795;41036.1792764143;41054.170429541904;41174.1765164695;41354.58645413568;42096.57903420988;7316.378107860892;7330.890036649348;7419.591922444101;7459.701611935462;7483.363914067365;30706.692933070382;31134.844325778227;31389.8430507846;31543.68456315499;31733.682663173997;36349.27301454009;36930.30696930285;37560.43659345058;39199.216015678954;39251;9655.372400793925;9671.564779584794;9839.065288797552;9937.354071985297;10089.344192627455;10318.638847640297;10599.364038157735;10916.890831091587;10948.945255273673;11136.10911127124;9588;9939.850902236616;10230.6419275325;10560.524776384927;10606.310589811637;9604.903950960681;9644.0355964403;9771.169450596779;9792.314537982273;9988.101070903364;9641.566129524048;9837.163841073303;10308.226882983656;10726.088282495763;10836.620718274822;8735.825283494167;9119.316051296311;9287.72136835896;9289.349745518019;9899.703008909744;9148.496832674;9274.118958698913;9414.388064775767;9484.95257523708;9500.572474238814 19:24:21 INFO - PROCESS | 2328 | __end_tp_report 19:24:21 INFO - PROCESS | 2328 | __start_cc_report 19:24:21 INFO - PROCESS | 2328 | _x_x_mozilla_cycle_collect,1087 19:24:21 INFO - PROCESS | 2328 | __end_cc_report 19:24:21 INFO - PROCESS | 2328 | __startTimestamp1452137061231__endTimestamp 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | ------- Summary: start ------- 19:24:21 INFO - PROCESS | 2328 | Number of tests: 6 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | [#0] dojo.html Cycles:165 Average:4581.76 Median:4728.72 stddev:478.62 (10.1%) stddev-sans-first:453.58 19:24:21 INFO - PROCESS | 2328 | Values: 2579.5 2689.3 2691.2 2705.0 2714.2 4499.6 4635.0 4657.7 4662.2 4667.1 4611.8 4613.4 4652.5 4669.9 4677.4 4209.6 4264.2 4281.6 4328.7 4357.1 4065.5 4305.1 4313.7 4356.9 4389.8 4114.3 4158.7 4183.4 4297.9 4313.8 4254.9 4259.3 4273.6 4290.2 4294.4 4043.5 4241.1 4258.1 4262.4 4298.6 4546.0 4558.6 4570.1 4584.9 4585.0 4894.0 4897.5 4975.8 4976.7 5015.1 5004.1 5022.6 5033.2 5069.3 5075.1 4437.5 4555.0 4649.6 4667.8 4703.6 4955.8 5038.0 5172.5 5175.1 5175.1 4882.7 4887.3 4889.2 4890.4 4937.8 4766.9 4886.8 4974.3 4977.0 4982.7 4776.5 4892.1 4976.5 4980.3 4981.3 4900.7 4912.4 4917.6 4923.2 4964.2 3988.5 4087.8 4162.0 4174.9 4223.3 3567.3 3571.6 3631.0 3659.4 3690.4 4334.8 4340.3 4341.6 4342.3 4382.1 4811.2 5000.9 5016.0 5016.2 5017.6 4214.9 4221.0 4222.2 4265.4 4347.4 4434.4 4446.7 4448.7 4479.5 4483.6 4762.5 4768.7 4769.8 4777.1 4819.6 4761.2 4887.6 4888.0 4990.1 5001.1 4615.8 4636.5 4638.5 4659.1 4741.9 4908.7 4937.5 4946.0 4988.6 4990.8 5014.9 5021.3 5022.3 5028.6 5061.2 4606.6 4728.7 4745.7 4807.0 4868.8 4825.1 4848.8 4854.1 4876.8 4897.6 4737.1 4761.5 4763.6 4768.4 4813.1 4651.4 4710.3 4756.0 4765.1 4870.3 4776.0 4790.8 4796.9 4807.7 4822.4 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | [#1] ext.html Cycles:180 Average:40906.39 Median:33167.92 stddev:66146.20 (199.4%) stddev-sans-first:66262.14 19:24:21 INFO - PROCESS | 2328 | Values: 488.7 521.9 526.4 544.3 547.7 24996.1 32832.8 33161.7 33174.2 33185.5 35991.0 36612.8 36684.0 36713.8 36725.0 6851.9 6963.6 7569.5 7793.3 7796.6 9842.1 10091.9 10092.6 10093.3 10096.7 9754.3 9793.3 9878.6 9884.8 9886.9 9782.4 9882.3 9885.0 9890.3 9893.7 9620.6 9768.0 9769.5 10103.7 10104.2 36014.0 36580.3 36752.3 36810.0 36851.0 2955.2 2966.2 2969.5 3017.8 3610.9 28359.6 28372.6 28529.4 28780.0 29181.7 3383.6 3470.8 3476.6 3554.0 3578.0 235599.0 235688.0 236001.0 236299.0 236499.0 46681.0 55648.7 55998.4 56073.4 56092.7 46098.5 58459.7 59881.9 59969.7 60022.8 14268.1 14547.9 14663.6 14671.2 14707.5 9412.4 9533.2 10480.9 10641.4 11040.1 18285.6 18669.4 18707.8 18730.2 18762.2 7458.8 7586.7 7674.4 7701.7 7776.3 808.7 817.1 889.3 891.7 921.8 22943.7 23331.0 23419.0 23422.3 23425.9 910.0 921.2 955.9 957.2 1014.6 12273.9 12731.0 12758.5 12775.6 12803.4 264001.0 268326.0 270371.0 270526.0 272033.2 44448.1 44867.3 44888.0 44902.8 45034.8 1188.6 1203.9 1211.5 1430.4 1430.6 23842.3 24398.4 24697.5 24790.6 24857.8 37020.1 37277.4 37341.1 37361.3 37362.8 235524.0 258820.0 260406.0 260491.0 261348.0 22348.7 28472.6 28980.4 29160.1 29408.9 33220.7 38893.4 39126.6 39964.4 40144.2 28846.4 32042.7 33481.3 33841.3 34265.0 28435.9 32277.2 32978.2 33303.9 37004.6 32349.5 32926.2 32933.0 33156.7 33242.0 28518.6 29060.9 29336.0 29429.9 29701.3 22838.4 23382.4 23781.5 24180.3 24403.9 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | [#2] jquery.html Cycles:180 Average:25881.05 Median:4111.99 stddev:77821.55 (1892.6%) stddev-sans-first:78016.21 19:24:21 INFO - PROCESS | 2328 | Values: 326.7 328.0 328.1 330.1 332.8 12389.2 12765.2 14698.9 15178.2 15198.2 12731.7 14359.6 15841.6 16679.2 16743.7 4837.3 4858.9 4980.8 4989.1 4990.8 3701.5 3828.3 4950.0 5009.8 5559.2 5628.7 5662.8 5685.3 5685.5 5688.5 5519.3 5645.1 5793.7 5800.8 5801.6 5051.3 5070.5 5082.3 5085.8 5088.4 17444.4 19080.4 19351.1 19477.1 19656.2 1794.6 1797.5 1799.5 1925.4 1926.4 12475.5 12485.5 12714.6 12834.3 12865.2 1656.6 1697.6 1706.0 1742.7 1764.2 48492.3 55691.4 58084.4 58303.0 58819.4 9742.7 9743.5 9744.8 9764.6 9806.0 12494.9 12529.6 12544.9 12551.8 12574.3 7106.7 7152.1 7179.5 7264.3 7346.4 6876.5 6883.9 6891.7 6993.1 7027.2 4108.6 4115.4 4139.4 4170.9 4173.1 1601.6 1623.6 1631.1 1679.2 1684.4 817.5 921.6 921.7 942.3 982.4 15371.5 15659.4 15780.7 16222.8 16226.8 790.8 834.1 858.4 861.7 920.3 8006.5 8401.4 8419.0 8428.7 8582.4 469021.0 475273.0 477420.0 477819.0 483732.0 69224.7 69301.7 69522.7 69783.7 71049.3 1049.1 1050.3 1052.2 1098.2 1103.2 13136.9 13199.5 13418.5 13486.0 13544.9 29266.6 29469.6 30085.0 30184.0 30232.7 39876.0 42310.2 42319.4 42548.8 43734.6 8866.7 8917.4 8949.8 9020.2 9034.8 12293.4 15914.1 16571.6 16644.4 16666.5 13683.7 13786.2 14061.9 14089.2 14105.6 12118.9 13267.5 13268.1 13876.5 14113.7 10582.4 10931.3 13160.0 13431.8 13673.1 8424.5 8633.5 8874.8 8900.0 8915.4 9086.4 9186.8 9559.4 13358.1 13399.9 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | [#3] mootools.html Cycles:180 Average:4827.23 Median:6134.81 stddev:2505.31 (40.8%) stddev-sans-first:2497.67 19:24:21 INFO - PROCESS | 2328 | Values: 1220.2 1393.1 1398.8 1517.5 1730.7 6013.3 6577.5 6666.1 6670.8 6682.4 6651.5 6796.6 6820.1 6821.8 6824.7 1692.7 1719.6 1721.2 2040.8 2091.5 2048.1 2072.5 2081.2 2084.8 2085.1 2029.7 2033.4 2038.1 2084.5 2084.5 2020.7 2060.6 2081.5 2092.2 2100.1 2070.8 2104.1 2110.2 2119.7 2121.8 6969.8 6986.0 7001.0 7015.5 7045.8 4090.1 4169.0 4170.4 4183.0 4186.0 2564.6 2626.0 2626.7 2638.1 2640.9 790.0 803.4 825.4 836.5 837.9 9405.0 9415.2 9415.4 9431.2 9433.1 3562.1 3597.0 3667.7 3676.1 3690.1 8139.0 8151.5 8165.1 8168.7 8169.3 4046.8 4051.1 4063.2 4072.3 4073.0 3677.7 3689.7 3691.0 3693.6 3695.6 2925.1 2979.0 3207.9 3357.3 3363.7 1000.2 1002.9 1004.0 1007.1 1007.6 862.2 864.6 869.5 902.1 923.5 6609.1 6641.9 6645.8 6652.9 6688.4 1021.1 1046.5 1050.1 1051.5 1077.7 5222.1 5264.2 5264.5 5265.2 5270.4 7979.3 8154.3 8171.9 8347.2 8432.7 7980.5 7997.2 8059.0 8081.3 8098.8 6410.0 6566.4 6611.6 6639.6 6640.9 6631.7 6694.1 6695.4 6697.7 6703.2 7155.4 7370.9 7404.0 7623.7 7649.8 7333.2 7431.6 7508.1 7754.2 7846.8 6166.8 6255.9 6267.8 6272.0 6281.1 6491.4 6625.3 6654.4 6694.0 6695.7 6122.8 6216.4 6218.2 6241.3 6278.2 6110.5 6140.6 6247.4 6298.3 6302.6 5992.7 6089.1 6134.3 6135.3 6142.8 5667.9 5681.9 5690.3 5693.0 5705.0 5634.3 5640.3 5643.9 5659.8 5670.7 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | [#4] prototype.html Cycles:180 Average:4680.78 Median:5353.34 stddev:1393.82 (26.0%) stddev-sans-first:1358.26 19:24:21 INFO - PROCESS | 2328 | Values: 292.3 295.8 300.2 301.7 301.8 5249.0 5275.2 5315.5 5351.4 5355.3 5241.0 5350.4 5362.6 5364.0 5371.6 4147.9 4150.7 4151.9 4156.1 4158.9 3927.3 4013.9 4019.5 4019.6 4136.6 4081.5 4083.7 4084.5 4107.2 4107.7 4087.0 4091.7 4098.4 4101.3 4110.5 3566.9 3588.9 3591.0 3597.5 3599.4 5009.9 5151.9 5162.1 5163.1 5200.7 4749.8 4756.7 4759.2 4760.3 4763.1 5672.5 5673.1 5679.3 5683.6 5696.7 3684.0 3769.6 3776.1 3841.6 3848.8 5850.2 5882.1 5889.2 5907.1 5908.7 4009.1 4010.1 4016.5 4016.6 4016.8 4065.9 4067.7 4072.8 4078.1 4079.3 4531.8 4653.7 4661.6 4662.1 4706.4 5629.7 5632.0 5635.4 5639.0 5657.9 1423.7 1443.8 1444.5 1447.6 1448.2 949.1 959.4 970.0 975.6 976.9 4989.2 4998.1 5001.4 5007.3 5010.0 5863.7 5865.1 5869.1 5871.9 5871.9 4957.2 4994.7 4994.9 4996.5 5004.7 3066.2 3132.7 3152.0 3162.7 3163.8 5532.4 5561.9 5604.4 5609.9 5614.3 6063.7 6068.9 6069.3 6070.7 6073.0 5587.9 5592.4 5600.6 5603.6 5606.6 5720.8 5912.8 5920.0 5932.1 5933.3 5476.8 5585.9 5697.2 5773.2 5793.5 5599.8 5614.4 5617.8 5625.5 5629.3 4028.5 4058.6 4060.1 4064.4 4064.6 5669.6 5869.5 5885.9 5895.0 5902.3 5666.4 5681.0 5687.4 5687.7 5713.8 5688.8 5694.3 5696.5 5698.8 5707.5 5596.9 5597.9 5598.2 5602.2 5607.2 5546.9 5684.0 5743.3 5760.5 5764.5 5577.6 5582.3 5584.7 5589.6 5590.8 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - PROCESS | 2328 | [#5] yui.html Cycles:180 Average:12018.80 Median:50315.50 stddev:13773.04 (27.4%) stddev-sans-first:13785.40 19:24:21 INFO - PROCESS | 2328 | Values: 689.1 715.5 730.0 758.8 790.2 10783.2 10938.9 10944.7 10945.7 10961.9 10335.6 10425.2 10495.7 10500.1 10501.0 614.8 622.8 789.0 793.5 809.5 804.5 807.1 810.0 810.8 812.0 832.8 841.3 842.3 842.3 843.0 639.6 647.8 830.4 845.5 849.6 626.2 630.6 631.1 631.1 631.5 10704.2 10827.5 10848.0 10856.8 10879.8 10085.2 10725.3 10801.2 11082.9 11226.7 9048.7 9064.1 9076.7 9227.6 9341.7 3234.4 3243.2 3260.1 3277.3 3311.7 38458.4 38658.0 38774.0 39306.8 39473.0 8914.5 8943.2 8971.7 9007.9 9074.4 16724.7 16759.0 16780.7 16804.6 16846.2 5754.3 6072.5 6088.6 6113.7 6213.3 3405.6 3478.8 3527.5 3541.4 3621.3 2611.4 2871.1 2941.3 2948.2 2949.7 501.0 509.1 510.2 514.5 518.2 448.9 461.8 464.5 563.3 590.2 7612.9 7629.0 7643.8 7673.4 7718.2 495.9 554.2 568.0 572.2 622.7 3626.8 3707.4 3741.9 3771.5 3810.3 48711.5 49519.0 49953.3 50271.7 50359.2 45030.5 45033.0 45355.8 45543.8 46795.0 41036.2 41054.2 41174.2 41354.6 42096.6 7316.4 7330.9 7419.6 7459.7 7483.4 30706.7 31134.8 31389.8 31543.7 31733.7 36349.3 36930.3 37560.4 39199.2 39251.0 9655.4 9671.6 9839.1 9937.4 10089.3 10318.6 10599.4 10916.9 10948.9 11136.1 9588.0 9939.9 10230.6 10560.5 10606.3 9604.9 9644.0 9771.2 9792.3 9988.1 9641.6 9837.2 10308.2 10726.1 10836.6 8735.8 9119.3 9287.7 9289.3 9899.7 9148.5 9274.1 9414.4 9485.0 9500.6 19:24:21 INFO - PROCESS | 2328 | -------- Summary: end -------- 19:24:21 INFO - PROCESS | 2328 | 19:24:21 INFO - TEST-INFO | 2328: exit 0 19:24:21 INFO - TEST-OK | dromaeo_css | took 1116896ms 19:24:21 INFO - TEST-START | kraken 19:24:21 INFO - operating with platform_type : linux_ 19:24:21 INFO - Initialising browser for kraken test... 19:24:22 INFO - TEST-INFO | started process 2613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuMlE8s/profile http://localhost:40209/getInfo.html) 19:24:26 INFO - PROCESS | 2613 | __metrics Screen width/height:1600/1200 19:24:26 INFO - PROCESS | 2613 | colorDepth:24 19:24:26 INFO - PROCESS | 2613 | Browser inner width/height: 1024/697 19:24:26 INFO - PROCESS | 2613 | __metrics 19:24:26 INFO - PROCESS | 2613 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:24:26 INFO - PROCESS | 2613 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:24:27 INFO - TEST-INFO | 2613: exit 0 19:24:27 INFO - Browser initialized. 19:24:27 INFO - Running cycle 1/1 for kraken test... 19:24:27 INFO - TEST-INFO | started process 2734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuMlE8s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:39 INFO - PROCESS | 2734 | RSS: Main: 150233088 19:24:39 INFO - PROCESS | 2734 | 19:24:41 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40209/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:42 INFO - PROCESS | 2734 | RSS: Main: 185319424 19:24:42 INFO - PROCESS | 2734 | 19:24:45 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40209/tests/kraken/driver.html?testName=audio-dft) 19:24:45 INFO - PROCESS | 2734 | RSS: Main: 176676864 19:24:45 INFO - PROCESS | 2734 | 19:24:48 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40209/tests/kraken/driver.html?testName=audio-fft) 19:24:49 INFO - PROCESS | 2734 | RSS: Main: 162856960 19:24:49 INFO - PROCESS | 2734 | 19:24:51 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40209/tests/kraken/driver.html?testName=audio-oscillator) 19:24:51 INFO - PROCESS | 2734 | RSS: Main: 162934784 19:24:51 INFO - PROCESS | 2734 | 19:24:54 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:54 INFO - PROCESS | 2734 | RSS: Main: 164630528 19:24:54 INFO - PROCESS | 2734 | 19:24:57 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40209/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:58 INFO - PROCESS | 2734 | RSS: Main: 164683776 19:24:58 INFO - PROCESS | 2734 | 19:25:01 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40209/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:02 INFO - PROCESS | 2734 | RSS: Main: 164691968 19:25:02 INFO - PROCESS | 2734 | 19:25:04 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40209/tests/kraken/driver.html?testName=json-parse-financial) 19:25:05 INFO - PROCESS | 2734 | RSS: Main: 164388864 19:25:05 INFO - PROCESS | 2734 | 19:25:07 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:07 INFO - PROCESS | 2734 | RSS: Main: 178024448 19:25:07 INFO - PROCESS | 2734 | 19:25:09 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:10 INFO - PROCESS | 2734 | RSS: Main: 174059520 19:25:10 INFO - PROCESS | 2734 | 19:25:12 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:13 INFO - PROCESS | 2734 | RSS: Main: 187002880 19:25:13 INFO - PROCESS | 2734 | 19:25:15 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:16 INFO - PROCESS | 2734 | RSS: Main: 189521920 19:25:16 INFO - PROCESS | 2734 | 19:25:18 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:19 INFO - PROCESS | 2734 | RSS: Main: 188784640 19:25:19 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | Cycle 1(1): loaded http://localhost:40209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40209/tests/kraken/driver.html?testName=ai-astar) 19:25:21 INFO - PROCESS | 2734 | RSS: Main: 246157312 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | __start_tp_report 19:25:21 INFO - PROCESS | 2734 | _x_x_mozilla_page_load 19:25:21 INFO - PROCESS | 2734 | _x_x_mozilla_page_load_details 19:25:21 INFO - PROCESS | 2734 | |i|pagename|runs| 19:25:21 INFO - PROCESS | 2734 | |0;ai-astar;112;113;108;113;113;113;103;112;113;120 19:25:21 INFO - PROCESS | 2734 | |1;audio-beat-detection;164;132;155;173;132;164;154;139;176;134 19:25:21 INFO - PROCESS | 2734 | |2;audio-dft;160;160;170;161;161;160;163;164;162;161 19:25:21 INFO - PROCESS | 2734 | |3;audio-fft;74;73;86;92;73;73;72;93;88;72 19:25:21 INFO - PROCESS | 2734 | |4;audio-oscillator;97;98;131;98;97;98;138;99;98;134 19:25:21 INFO - PROCESS | 2734 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;109 19:25:21 INFO - PROCESS | 2734 | |6;imaging-darkroom;148;147;146;147;147;148;147;147;147;146 19:25:21 INFO - PROCESS | 2734 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 19:25:21 INFO - PROCESS | 2734 | |8;json-parse-financial;70;70;72;69;71;69;71;79;68;68 19:25:21 INFO - PROCESS | 2734 | |9;json-stringify-tinderbox;68;69;68;69;69;69;69;69;69;69 19:25:21 INFO - PROCESS | 2734 | |10;stanford-crypto-aes;83;91;83;84;84;84;84;83;85;85 19:25:21 INFO - PROCESS | 2734 | |11;stanford-crypto-ccm;124;128;127;119;127;121;123;121;121;122 19:25:21 INFO - PROCESS | 2734 | |12;stanford-crypto-pbkdf2;137;134;149;158;144;140;147;136;138;136 19:25:21 INFO - PROCESS | 2734 | |13;stanford-crypto-sha256-iterative;72;71;70;72;71;70;70;71;70;70 19:25:21 INFO - PROCESS | 2734 | __end_tp_report 19:25:21 INFO - PROCESS | 2734 | __start_cc_report 19:25:21 INFO - PROCESS | 2734 | _x_x_mozilla_cycle_collect,989 19:25:21 INFO - PROCESS | 2734 | __end_cc_report 19:25:21 INFO - PROCESS | 2734 | __startTimestamp1452137121342__endTimestamp 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | ------- Summary: start ------- 19:25:21 INFO - PROCESS | 2734 | Number of tests: 14 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:4.29 (3.8%) stddev-sans-first:4.56 19:25:21 INFO - PROCESS | 2734 | Values: 112.0 113.0 108.0 113.0 113.0 113.0 103.0 112.0 113.0 120.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:159.50 stddev:17.03 (10.7%) stddev-sans-first:17.53 19:25:21 INFO - PROCESS | 2734 | Values: 164.0 132.0 155.0 173.0 132.0 164.0 154.0 139.0 176.0 134.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:3.05 (1.9%) stddev-sans-first:3.13 19:25:21 INFO - PROCESS | 2734 | Values: 160.0 160.0 170.0 161.0 161.0 160.0 163.0 164.0 162.0 161.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#3] audio-fft Cycles:10 Average:79.60 Median:80.00 stddev:8.96 (11.2%) stddev-sans-first:9.27 19:25:21 INFO - PROCESS | 2734 | Values: 74.0 73.0 86.0 92.0 73.0 73.0 72.0 93.0 88.0 72.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:98.00 stddev:17.71 (18.1%) stddev-sans-first:18.26 19:25:21 INFO - PROCESS | 2734 | Values: 97.0 98.0 131.0 98.0 97.0 98.0 138.0 99.0 98.0 134.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:25:21 INFO - PROCESS | 2734 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 19:25:21 INFO - PROCESS | 2734 | Values: 148.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 147.0 146.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:25:21 INFO - PROCESS | 2734 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:70.50 stddev:3.20 (4.5%) stddev-sans-first:3.38 19:25:21 INFO - PROCESS | 2734 | Values: 70.0 70.0 72.0 69.0 71.0 69.0 71.0 79.0 68.0 68.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 19:25:21 INFO - PROCESS | 2734 | Values: 68.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:2.37 (2.8%) stddev-sans-first:2.44 19:25:21 INFO - PROCESS | 2734 | Values: 83.0 91.0 83.0 84.0 84.0 84.0 84.0 83.0 85.0 85.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:123.50 stddev:3.09 (2.5%) stddev-sans-first:3.27 19:25:21 INFO - PROCESS | 2734 | Values: 124.0 128.0 127.0 119.0 127.0 121.0 123.0 121.0 121.0 122.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:142.00 stddev:7.56 (5.3%) stddev-sans-first:7.81 19:25:21 INFO - PROCESS | 2734 | Values: 137.0 134.0 149.0 158.0 144.0 140.0 147.0 136.0 138.0 136.0 19:25:21 INFO - PROCESS | 2734 | 19:25:21 INFO - PROCESS | 2734 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 19:25:21 INFO - PROCESS | 2734 | Values: 72.0 71.0 70.0 72.0 71.0 70.0 70.0 71.0 70.0 70.0 19:25:21 INFO - PROCESS | 2734 | -------- Summary: end -------- 19:25:21 INFO - PROCESS | 2734 | 19:25:22 INFO - TEST-INFO | 2734: exit 0 19:25:22 INFO - TEST-OK | kraken | took 60345ms 19:25:22 INFO - TEST-START | v8_7 19:25:22 INFO - operating with platform_type : linux_ 19:25:22 INFO - Initialising browser for v8_7 test... 19:25:22 INFO - TEST-INFO | started process 3049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpchni8v/profile http://localhost:40209/getInfo.html) 19:25:26 INFO - PROCESS | 3049 | __metrics Screen width/height:1600/1200 19:25:26 INFO - PROCESS | 3049 | colorDepth:24 19:25:26 INFO - PROCESS | 3049 | Browser inner width/height: 1024/697 19:25:26 INFO - PROCESS | 3049 | __metrics 19:25:26 INFO - PROCESS | 3049 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:25:26 INFO - PROCESS | 3049 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:27 INFO - TEST-INFO | 3049: exit 0 19:25:27 INFO - Browser initialized. 19:25:27 INFO - Running cycle 1/1 for v8_7 test... 19:25:27 INFO - TEST-INFO | started process 3128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpchni8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:39 INFO - PROCESS | 3128 | RSS: Main: 150093824 19:25:39 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | Cycle 1(1): loaded http://localhost:40209/tests/v8_7/run.html (next: http://localhost:40209/tests/v8_7/run.html) 19:26:01 INFO - PROCESS | 3128 | RSS: Main: 449277952 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | __start_tp_report 19:26:01 INFO - PROCESS | 3128 | _x_x_mozilla_page_load 19:26:01 INFO - PROCESS | 3128 | _x_x_mozilla_page_load_details 19:26:01 INFO - PROCESS | 3128 | |i|pagename|runs| 19:26:01 INFO - PROCESS | 3128 | |0;Richards;166.72224074691565 19:26:01 INFO - PROCESS | 3128 | |1;DeltaBlue;194.70404984423675 19:26:01 INFO - PROCESS | 3128 | |2;Encrypt;282.80542986425337 19:26:01 INFO - PROCESS | 3128 | |3;Decrypt;5263.1578947368425 19:26:01 INFO - PROCESS | 3128 | |4;RayTrace;2008.0321285140562 19:26:01 INFO - PROCESS | 3128 | |5;Earley;815.6606851549756 19:26:01 INFO - PROCESS | 3128 | |6;Boyer;11870.588235294117 19:26:01 INFO - PROCESS | 3128 | |7;RegExp;26447.36842105263 19:26:01 INFO - PROCESS | 3128 | |8;Splay;603.1363088057901 19:26:01 INFO - PROCESS | 3128 | |9;NavierStokes;4835.748792270531 19:26:01 INFO - PROCESS | 3128 | __end_tp_report 19:26:01 INFO - PROCESS | 3128 | __startTimestamp1452137161263__endTimestamp 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | ------- Summary: start ------- 19:26:01 INFO - PROCESS | 3128 | Number of tests: 10 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#0] Richards Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 166.7 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#1] DeltaBlue Cycles:1 Average:194.70 Median:194.70 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 194.7 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 282.8 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 5263.2 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#4] RayTrace Cycles:1 Average:2008.03 Median:2008.03 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 2008.0 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#5] Earley Cycles:1 Average:815.66 Median:815.66 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 815.7 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#6] Boyer Cycles:1 Average:11870.59 Median:11870.59 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 11870.6 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 26447.4 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#8] Splay Cycles:1 Average:603.14 Median:603.14 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 603.1 19:26:01 INFO - PROCESS | 3128 | 19:26:01 INFO - PROCESS | 3128 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:26:01 INFO - PROCESS | 3128 | Values: 4835.7 19:26:01 INFO - PROCESS | 3128 | -------- Summary: end -------- 19:26:01 INFO - PROCESS | 3128 | 19:26:02 INFO - TEST-INFO | 3128: exit 0 19:26:02 INFO - TEST-OK | v8_7 | took 39910ms 19:26:02 INFO - SUITE-END | took 1217s 19:26:02 INFO - Completed test suite (00:20:17) 19:26:02 INFO - Working with test: dromaeo_css 19:26:02 INFO - Generating results file: dromaeo_css 19:26:02 INFO - Working with test: kraken 19:26:02 INFO - Generating results file: kraken 19:26:02 INFO - javascript benchmark 19:26:02 INFO - Working with test: v8_7 19:26:02 INFO - Generating results file: v8_7 19:26:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:26:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 19:26:02 INFO - process_Request line: dromaeo_css 6244.55 graph.html#tests=[[72,203,35]] 19:26:02 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:26:02 INFO - process_Request line: kraken 1526.90 graph.html#tests=[[232,203,35]] 19:26:02 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:26:02 INFO - process_Request line: v8_7 19651.02 graph.html#tests=[[230,203,35]] 19:26:02 INFO - RETURN: dromaeo_css: 6244.55 19:26:02 INFO - RETURN: kraken: 1526.90 19:26:02 INFO - RETURN: v8_7: 19651.02 19:26:02 INFO - javascript benchmark 19:26:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2579.4841031793644, 2689.327668082978, 2691.2329985953984, 2704.9864750676243, 2714.1721774858665, 4499.595036446719, 4635.049814787969, 4657.720536767796, 4662.160811054009, 4667.136579732747, 4611.769411529419, 4613.423322084739, 4652.46496652885, 4669.929951050737, 4677.415323084614, 4209.579042095781, 4264.189803937242, 4281.614654681086, 4328.740275583459, 4357.085012147453, 4065.5324637666604, 4305.052888364555, 4313.676474264427, 4356.934645980297, 4389.802458889341, 4114.321137012389, 4158.729682570638, 4183.372494125875, 4297.935530967038, 4313.82744690212, 4254.936175957363, 4259.254630439692, 4273.594008569181, 4290.206311832289, 4294.398784170187, 4043.4541336919433, 4241.130568233536, 4258.105797782469, 4262.360645903108, 4298.570142985708, 4546.0, 4558.61251793598, 4570.063137056895, 4584.931226031612, 4584.977075114636, 4894.0, 4897.461279259314, 4975.776090075955, 4976.726280054596, 5015.072211640858, 5004.074246264453, 5022.598192144656, 5033.219850923113, 5069.290299358093, 5075.111855425286, 4437.489688685778, 4555.043440877453, 4649.604783593399, 4667.836625718083, 4703.64722645803, 4955.752212389366, 5038.0, 5172.508611681884, 5175.120229560984, 5175.146100893386, 4882.6826256293225, 4887.266909963463, 4889.242167464049, 4890.437599676012, 4937.802487900515, 4766.856994290177, 4886.804527818918, 4974.27872958419, 4976.975115124474, 4982.701037937735, 4776.522347765195, 4892.0705066037335, 4976.5023497649945, 4980.327655766498, 4981.341145638719, 4900.705957642553, 4912.410510738663, 4917.557419832232, 4923.163062279421, 4964.15609346412, 3988.521377434726, 4087.8364865405647, 4162.0, 4174.895627609334, 4223.345381465878, 3567.250877315793, 3571.5714114306447, 3630.983324669097, 3659.3596120678776, 3690.391085470921, 4334.761588112621, 4340.30555111187, 4341.609255166987, 4342.305231163062, 4382.101669157815, 4811.158047341702, 5000.874978125576, 5016.02187573427, 5016.247562865599, 5017.648764586517, 4214.936775948363, 4220.957790422118, 4222.239996800606, 4265.445492086009, 4347.413099231627, 4434.423524941737, 4446.666500012512, 4448.733076015449, 4479.484859241164, 4483.574060464251, 4762.499937506581, 4768.737719425465, 4769.833055843098, 4777.116233496675, 4819.59033482158, 4761.2382018876815, 4887.584555312696, 4887.975560122177, 4990.126727822689, 5001.149804533311, 4615.838445654386, 4636.536346365337, 4638.512956139557, 4659.114768194032, 4741.881452963704, 4908.680935739166, 4937.530934561211, 4946.0, 4988.551030407136, 4990.8003679853855, 5014.899702006012, 5021.3472248608905, 5022.271770593316, 5028.64799464034, 5061.164907790173, 4606.56237657422, 4728.71627702339, 4745.667803253739, 4806.975965120152, 4868.805247790048, 4825.10735513931, 4848.781804818721, 4854.077725232195, 4876.780544875418, 4897.559219670246, 4737.099951009297, 4761.547652972962, 4763.618910487084, 4768.380110585602, 4813.085513752376, 4651.395318608695, 4710.293455981493, 4755.952440475551, 4765.0946320199055, 4870.342503761947, 4775.952240477551, 4790.8323208687525, 4796.880077998078, 4807.663463557517, 4822.397200349957], "unit": "score", "name": "dojo.html", "value": 4552.1620066218065}, {"lowerIsBetter": false, "replicates": [488.73608251544147, 521.8877941242632, 526.3709866709281, 544.3196004993757, 547.6768706463189, 24996.125135620256, 32832.83583582082, 33161.66838331619, 33174.17064573381, 33185.502217466696, 35991.0, 36612.81693591528, 36684.0, 36713.816430917876, 36725.0, 6851.862962740742, 6963.582185068912, 7569.545827250369, 7793.2596403341595, 7796.6491507882, 9842.114209721123, 10091.949540252324, 10092.596296148145, 10093.343932644355, 10096.69709908704, 9754.317197796121, 9793.26550508711, 9878.555465004092, 9884.802303953917, 9886.90113098867, 9782.364146330467, 9882.258830587734, 9885.0, 9890.258230632731, 9893.703188904381, 9620.567074481665, 9767.951160244224, 9769.462679552622, 10103.696889093339, 10104.191664666883, 36014.0, 36580.26839463222, 36752.26495470102, 36810.0, 36851.0, 2955.246412164884, 2966.1991262359256, 2969.503606110234, 3017.7585793136495, 3610.855565777366, 28359.57460638092, 28372.574411383845, 28529.429411411656, 28779.985401021935, 29181.70818291811, 3383.6278009418943, 3470.8438120284395, 3476.6001909780193, 3553.987113672591, 3577.964220357815, 235599.0, 235688.0, 236001.0, 236299.0, 236499.0, 46681.0, 55648.72175639096, 55998.440015600136, 56073.43926560764, 56092.719536402874, 46098.53901460942, 58459.70770146207, 59881.910037647285, 59969.70015149896, 60022.79954400888, 14268.14391136535, 14547.927260363631, 14663.633409164857, 14671.193084380462, 14707.485238016618, 9412.388194767318, 9533.237341012702, 10480.947595261974, 10641.414722190353, 11040.116790656728, 18285.63428731418, 18669.43991680252, 18707.75506939149, 18730.1571429286, 18762.249510019446, 7458.813529661693, 7586.734464293723, 7674.429066262753, 7701.653425595861, 7776.339011184, 808.7412028151053, 817.1297568089965, 889.2707979456783, 891.6567121658079, 921.824853277875, 22943.655845162335, 23331.0, 23419.0, 23422.297331080095, 23425.88287058588, 909.9545022748836, 921.2491819167357, 955.8709574207393, 957.1720461800493, 1014.5688082564881, 12273.938630306791, 12731.0, 12758.48966041348, 12775.552855650008, 12803.35983200855, 264001.0, 268326.0, 270371.0, 270526.0, 272033.1568500989, 44448.11103777906, 44867.32699009518, 44888.0, 44902.77548612236, 45034.77482612631, 1188.6255829413708, 1203.867574566797, 1211.4548453196096, 1430.4278288684402, 1430.6351880270672, 23842.3428822565, 24398.390040249134, 24697.5277484869, 24790.628140577544, 24857.751422485544, 37020.074498137765, 37277.440838387985, 37341.06647333838, 37361.25277494381, 37362.8131859339, 235524.0, 258820.0, 260406.0, 260491.0, 261348.0, 22348.664770028787, 28472.572911406758, 28980.42039159163, 29160.125196244146, 29408.852955735085, 33220.667793322726, 38893.416598750475, 39126.6087339123, 39964.40053399259, 40144.1971160581, 28846.423071538033, 32042.679573203968, 33481.33037339191, 33841.32317353688, 34265.0, 28435.92030924786, 32277.193070173435, 32978.17554561155, 33303.864423033934, 37004.629953701195, 32349.514757279132, 32926.17684557905, 32933.0, 33156.66843331536, 33242.0, 28518.57222141628, 29060.85814360794, 29336.0, 29429.85285073561, 29701.257468563457, 22838.429039273487, 23382.415439614146, 23781.52436951286, 24180.274591762274, 24403.877980609985], "unit": "score", "name": "ext.html", "value": 16935.712482266226}, {"lowerIsBetter": false, "replicates": [326.6554820882265, 327.97212236959865, 328.09936723693465, 330.0922463226128, 332.7720511449657, 12389.19470234434, 12765.23408595485, 14698.926505367472, 15178.2410879456, 15198.240087995597, 12731.745365092693, 14359.641008974755, 15841.603959901007, 16679.24943377548, 16743.748843767324, 4837.298591704201, 4858.902821943559, 4980.750962451881, 4989.126902792015, 4990.75046247688, 3701.463287823264, 3828.3109040372724, 4949.975250123744, 5009.799608015675, 5559.166125081229, 5628.746706398222, 5662.801801936933, 5685.317761868581, 5685.45988131129, 5688.544916406678, 5519.282493275869, 5645.125005624135, 5793.7392817323325, 5800.8259752207505, 5801.564882633819, 5051.343325367716, 5070.543651071422, 5082.263071854561, 5085.847424577269, 5088.363954505687, 17444.389446369318, 19080.427587172268, 19351.12919918607, 19477.12352944121, 19656.213751449926, 1794.6231291428815, 1797.4607617714632, 1799.5411170151528, 1925.3838771593096, 1926.412444204517, 12475.50097996079, 12485.50057997679, 12714.61856144317, 12834.294113823737, 12865.228086314852, 1656.5527307626994, 1697.6265221651217, 1705.9914700426418, 1742.7298768690746, 1764.2325588369101, 48492.272615910435, 55691.44308556903, 58084.44902162734, 58303.0, 58819.41180588182, 9742.659006934724, 9743.464109474047, 9744.805103898025, 9764.609415623296, 9805.989772096704, 12494.875051249554, 12529.624111276677, 12544.937275313565, 12551.811722823983, 12574.30841303737, 7106.680199391039, 7152.105986751656, 7179.461540384492, 7264.34620884123, 7346.375558077516, 6876.484263680244, 6883.862322753517, 6891.724331026803, 6993.0908981832035, 7027.15674119109, 4108.623611090258, 4115.36211887158, 4139.399787030924, 4170.91658166841, 4173.144505376391, 1601.6476375197437, 1623.6427985843095, 1631.1354981859633, 1679.177203170462, 1684.3683618643008, 817.5340056168046, 921.6405601815297, 921.709661456639, 942.2838642631513, 982.4301904895144, 15371.461998830211, 15659.37362505487, 15780.68438631221, 16222.756658650129, 16226.837731622532, 790.7904405332591, 834.1366685480499, 858.4420126917554, 861.7199410191713, 920.2637889688223, 8006.519608823489, 8401.411901166983, 8418.957905210556, 8428.704995325133, 8582.356323275779, 469021.0, 475273.0, 477420.0, 477819.0, 483732.0, 69224.6538767303, 69301.65349173221, 69522.65238673876, 69783.65108174528, 71049.2895071053, 1049.1187402581868, 1050.2700623067049, 1052.2055847834836, 1098.181854518389, 1103.178132291448, 13136.868631313564, 13199.472021119047, 13418.530351437652, 13486.0, 13544.86455135436, 29266.561001584567, 29469.55795663024, 30085.0, 30184.0, 30232.697673022987, 39876.0, 42310.153796923274, 42319.36520952127, 42548.78725606352, 43734.56265437432, 8866.689665861664, 8917.42036767608, 8949.776255593662, 9020.233280171258, 9034.819303614022, 12293.44679489443, 15914.124723140338, 16571.585710357336, 16644.417445389354, 16666.50000499987, 13683.657908552366, 13786.172829630254, 14061.859381406055, 14089.225092619594, 14105.647358816112, 12118.878811211775, 13267.535636252685, 13268.13757105785, 13876.514321998682, 14113.717725645225, 10582.417967011581, 10931.289466184673, 13160.0, 13431.798523022358, 13673.111247768864, 8424.536650484282, 8633.525156116473, 8874.778130546789, 8899.955500222457, 8915.37592368528, 9086.409383390059, 9186.770330741518, 9559.426434413957, 13358.131721438076, 13399.933000334935], "unit": "score", "name": "jquery.html", "value": 8229.664148207794}, {"lowerIsBetter": false, "replicates": [1220.2251570252886, 1393.1014495650306, 1398.8321401431826, 1517.5295658345913, 1730.7057800173968, 6013.27840659121, 6577.50668699847, 6666.13340265766, 6670.76652317169, 6682.398584127428, 6651.501137414689, 6796.626185559805, 6820.11338525991, 6821.761238356658, 6824.692888820003, 1692.678391105686, 1719.5787032177134, 1721.2254485481521, 2040.8367330613553, 2091.5294058836794, 2048.057893369052, 2072.5336799220204, 2081.157131361801, 2084.760252570951, 2085.092984551725, 2029.6853987631941, 2033.4001469566513, 2038.1134206620093, 2084.4893001214723, 2084.5414008918015, 2020.7069974853564, 2060.649689552772, 2081.479630092477, 2092.194505115534, 2100.0654708654656, 2070.7989366167585, 2104.095239047209, 2110.2192188890053, 2119.692644566529, 2121.8302535797097, 6969.825754356131, 6986.0, 7000.9649951750425, 7015.47383946201, 7045.823854403681, 4090.1001779608737, 4168.979155104205, 4170.35359519275, 4182.954261434641, 4185.97907010466, 2564.5640241158862, 2626.0283695032767, 2626.737326267358, 2638.103044964702, 2640.854752988585, 789.9763007109796, 803.3974519110667, 825.3892119831341, 836.4521238588734, 837.8659414493712, 9405.0, 9415.199708024826, 9415.387999780061, 9431.245500359955, 9433.103855133751, 3562.091666624994, 3597.0, 3667.7065834733157, 3676.0809797550614, 3690.095926498025, 8139.0, 8151.470154439942, 8165.101838797727, 8168.714095006646, 8169.305609023299, 4046.77742724153, 4051.088505086332, 4063.227986682521, 4072.3484242521645, 4073.042834933788, 3677.687396571268, 3689.7417180797624, 3691.0218792020137, 3693.612170722089, 3695.593484716679, 2925.093221101465, 2978.955315670267, 3207.919802004922, 3357.278185190196, 3363.680450357212, 1000.2448151645607, 1002.9348092373972, 1003.9698809035741, 1007.123802291996, 1007.5566750629699, 862.2283056664376, 864.6238886084574, 869.5261082709939, 902.0979020979021, 923.4782347973373, 6609.1077704510235, 6641.86716265672, 6645.800625981132, 6652.866942661217, 6688.3646053624825, 1021.1473419694489, 1046.534292239946, 1050.0811789684026, 1051.4847724614883, 1077.7251800790905, 5222.138347172674, 5264.157734762496, 5264.526192642604, 5265.157574788015, 5270.420253772082, 7979.321757650665, 8154.306883914815, 8171.9182808172345, 8347.248747612623, 8432.704855330034, 7980.481268717631, 7997.240262175084, 8059.032916050111, 8081.3130883874355, 8098.838023239502, 6410.038494225811, 6566.4418524425955, 6611.603303801788, 6639.634820084845, 6640.900386494206, 6631.701573429111, 6694.062831203538, 6695.397414232742, 6697.665116744241, 6703.195616526048, 7155.356017958408, 7370.889436658562, 7404.037475128199, 7623.69505219785, 7649.847003059796, 7333.230010848784, 7431.628418579157, 7508.136564295176, 7754.185810490043, 7846.843063138819, 6166.784162554289, 6255.874882502416, 6267.780627678009, 6272.0, 6281.057841323838, 6491.4482269005775, 6625.271220165874, 6654.401103900672, 6694.0, 6695.7321707133115, 6122.785702500391, 6216.44052035319, 6218.22272215973, 6241.251049874044, 6278.152449419453, 6110.480609148094, 6140.631562106288, 6247.437730604267, 6298.275698294571, 6302.5588208826775, 5992.730327135202, 6089.056196289582, 6134.325224225242, 6135.294441139147, 6142.846428839315, 5667.914981275367, 5681.857953551194, 5690.2887139107615, 5692.971535142297, 5704.971475142598, 5634.267545219095, 5640.32316122068, 5643.915341269802, 5659.773609055756, 5670.659760414388], "unit": "score", "name": "mootools.html", "value": 3952.7354109885396}, {"lowerIsBetter": false, "replicates": [292.3247298739911, 295.7707776473233, 300.2493765586035, 301.74502545349185, 301.82494153391036, 5248.973755131219, 5275.235090911816, 5315.548178404835, 5351.411344752084, 5355.277037599928, 5241.0, 5350.438203988583, 5362.570994320455, 5364.0, 5371.57027437805, 4147.8963025924295, 4150.667946564267, 4151.937720934188, 4156.106437116019, 4158.8544400945975, 3927.253821773868, 4013.8996525086814, 4019.477467929165, 4019.638232559069, 4136.648384887289, 4081.469408976829, 4083.6528895043957, 4084.4690190275373, 4107.1580326033245, 4107.712460127792, 4087.0395457067716, 4091.734037287567, 4098.385242213662, 4101.343784994401, 4110.527289361732, 3566.857325706969, 3588.856445742167, 3591.0304217861294, 3597.460380942853, 3599.3881040222964, 5009.924851127236, 5151.922721159186, 5162.1224391853475, 5163.122269214205, 5200.739963001873, 4749.762511874427, 4756.7145971241835, 4759.190937540592, 4760.33355330254, 4763.071201115784, 5672.5178359839465, 5673.063944449161, 5679.261695979538, 5683.630564013367, 5696.743646535916, 3684.0237337105686, 3769.604191559874, 3776.131489757344, 3841.5582208046153, 3848.807559622008, 5850.210221620069, 5882.117682347639, 5889.204957330749, 5907.113932910098, 5908.704564771744, 4009.0779120801794, 4010.137820368635, 4016.477857878457, 4016.59834016596, 4016.758994460342, 4065.8576949807207, 4067.654249388835, 4072.7963601819793, 4078.1028173801715, 4079.326911059642, 4531.799073245593, 4653.697509661861, 4661.627069834405, 4662.090892275974, 4706.388169537938, 5629.746661400247, 5632.0, 5635.380108188096, 5638.971805140948, 5657.9434205658235, 1423.6939058102557, 1443.8483959184343, 1444.4655477473402, 1447.6453268949174, 1448.2324368084933, 949.084133810862, 959.4195511715451, 969.9903000970041, 975.5805003848271, 976.9413835169912, 4989.226669866177, 4998.125328067574, 5001.374828146481, 5007.3240112584335, 5010.0, 5863.70681465925, 5865.149553314745, 5869.119632055226, 5871.882562348815, 5871.94128058714, 4957.206846904478, 4994.650374473752, 4994.875128121754, 4996.475370086088, 5004.699718016931, 3066.1874603230162, 3132.6554079051284, 3151.952720709191, 3162.667919868427, 3163.813569911283, 5532.419095994943, 5561.944380556223, 5604.41153678866, 5609.943900561024, 5614.29821272341, 6063.696815159225, 6068.908966365508, 6069.332373438918, 6070.666113363719, 6072.967595508774, 5587.944120558743, 5592.384837667934, 5600.635958662674, 5603.607747457639, 5606.579506537026, 5720.771169153354, 5912.763489460373, 5920.0, 5932.080527518242, 5933.347331793586, 5476.835694929158, 5585.944140558542, 5697.23087383198, 5773.191753154478, 5793.478586927196, 5599.776008959759, 5614.354349249888, 5617.837132703857, 5625.46558076982, 5629.3244810621345, 4028.4762980812307, 4058.6347228749555, 4060.0661847774586, 4064.4106604541585, 4064.6138616831354, 5669.574781891292, 5869.4717475427415, 5885.911711324419, 5894.970525147347, 5902.2622172228475, 5666.405027472056, 5681.0, 5687.402822703557, 5687.658740475585, 5713.771449141987, 5688.800891968761, 5694.259746232963, 5696.515796157208, 5698.800541981011, 5707.514861236841, 5596.944030559643, 5597.888042239214, 5598.216249725123, 5602.187682785891, 5607.243022191952, 5546.889062218814, 5684.033714268667, 5743.310802703702, 5760.481556659921, 5764.48119669215, 5577.637453565505, 5582.33012038558, 5584.720763961867, 5589.636673616202, 5590.7763689453595], "unit": "score", "name": "prototype.html", "value": 4229.366987396747}, {"lowerIsBetter": false, "replicates": [689.090400671114, 715.470551791674, 729.9963500182502, 758.8292634157314, 790.1505881177735, 10783.191260655452, 10938.945305273472, 10944.726381840457, 10945.726356841064, 10961.945190274047, 10335.638252661158, 10425.218108641844, 10495.73760655982, 10500.107490863267, 10501.002404771554, 614.8032629558543, 622.7540121651945, 788.9881651775228, 793.5238856685971, 809.4778867630375, 804.4610111225493, 807.1000834070028, 809.955452450115, 810.781089105944, 812.0417906869891, 832.7585000349891, 841.3185319890878, 842.2588122452233, 842.3050982939069, 842.9915700842975, 639.5682914033032, 647.7894684227622, 830.3979614779267, 845.4969293270556, 849.5964416901923, 626.2141013028665, 630.552307861419, 631.1227393922452, 631.1384959530208, 631.5200447659765, 10704.19718521114, 10827.512761925653, 10848.0, 10856.837147442795, 10879.782404351949, 10085.193184545218, 10725.30285531438, 10801.243912926098, 11082.944585277022, 11226.719332016683, 9048.683296084671, 9064.138906803842, 9076.693192480108, 9227.630894764201, 9341.719748407559, 3234.4339740545547, 3243.189202699325, 3260.0708797992697, 3277.2626159114247, 3311.6522765109557, 38458.42312365317, 38658.0, 38774.0, 39306.803465982775, 39473.0, 8914.509701966454, 8943.195112439911, 8971.685990990414, 9007.909920900838, 9074.364794464323, 16724.749128762836, 16759.0, 16780.748288775678, 16804.579885502717, 16846.220373638458, 5754.251947246831, 6072.51419886408, 6088.573799833969, 6113.694315284218, 6213.285472170758, 3405.5743032120986, 3478.826058697055, 3527.470879368064, 3541.3979623464074, 3621.27574485104, 2611.360216746871, 2871.0956048844546, 2941.3087924337765, 2948.2334593005544, 2949.705029497076, 500.9624278179151, 509.09381301283776, 510.21427002416607, 514.4932241741881, 518.1683398145997, 448.8586095379945, 461.7945014468529, 464.4728233455053, 563.2790028763189, 590.2415396215843, 7612.923870761332, 7629.046369203849, 7643.770686879402, 7673.386129109658, 7718.151003389623, 495.89090400111917, 554.2462251338177, 567.9943200568024, 572.1732097119706, 622.7197761007474, 3626.8367923443507, 3707.3697471429923, 3741.9251614967548, 3771.5097037385513, 3810.2950954073585, 48711.51288487141, 49519.0, 49953.25070123951, 50271.74864125729, 50359.24461133086, 45030.549694503294, 45033.0, 45355.77322113435, 45543.77228113905, 46795.0, 41036.1792764143, 41054.170429541904, 41174.1765164695, 41354.58645413568, 42096.57903420988, 7316.378107860892, 7330.890036649348, 7419.591922444101, 7459.701611935462, 7483.363914067365, 30706.692933070382, 31134.844325778227, 31389.8430507846, 31543.68456315499, 31733.682663173997, 36349.27301454009, 36930.30696930285, 37560.43659345058, 39199.216015678954, 39251.0, 9655.372400793925, 9671.564779584794, 9839.065288797552, 9937.354071985297, 10089.344192627455, 10318.638847640297, 10599.364038157735, 10916.890831091587, 10948.945255273673, 11136.10911127124, 9588.0, 9939.850902236616, 10230.6419275325, 10560.524776384927, 10606.310589811637, 9604.903950960681, 9644.0355964403, 9771.169450596779, 9792.314537982273, 9988.101070903364, 9641.566129524048, 9837.163841073303, 10308.226882983656, 10726.088282495763, 10836.620718274822, 8735.825283494167, 9119.316051296311, 9287.72136835896, 9289.349745518019, 9899.703008909744, 9148.496832674, 9274.118958698913, 9414.388064775767, 9484.95257523708, 9500.572474238814], "unit": "score", "name": "yui.html", "value": 5589.610644922717}], "name": "dromaeo_css", "value": 6244.5448602936185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 113.0, 113.0, 113.0, 103.0, 112.0, 113.0, 120.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [164.0, 132.0, 155.0, 173.0, 132.0, 164.0, 154.0, 139.0, 176.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 170.0, 161.0, 161.0, 160.0, 163.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 86.0, 92.0, 73.0, 73.0, 72.0, 93.0, 88.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 131.0, 98.0, 97.0, 98.0, 138.0, 99.0, 98.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 69.0, 71.0, 69.0, 71.0, 79.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 83.0, 84.0, 84.0, 84.0, 84.0, 83.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [124.0, 128.0, 127.0, 119.0, 127.0, 121.0, 123.0, 121.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [137.0, 134.0, 149.0, 158.0, 144.0, 140.0, 147.0, 136.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 70.0, 72.0, 71.0, 70.0, 70.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1526.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "Richards", "value": 211.74139599999998}, {"lowerIsBetter": false, "replicates": [194.70404984423675], "unit": "score", "name": "DeltaBlue", "value": 339.58204800000004}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [2008.0321285140562], "unit": "score", "name": "RayTrace", "value": 368.51452200000006}, {"lowerIsBetter": false, "replicates": [815.6606851549756], "unit": "score", "name": "Earley", "value": 817.0836380000003}, {"lowerIsBetter": false, "replicates": [11870.588235294117], "unit": "score", "name": "Boyer", "value": 56.1440584737364}, {"lowerIsBetter": false, "replicates": [26447.36842105263], "unit": "score", "name": "RegExp", "value": 34.44520398009948}, {"lowerIsBetter": false, "replicates": [603.1363088057901], "unit": "score", "name": "Splay", "value": 135.11207800000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19651.022508395778}]} 19:26:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19651.02"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6244.55"}}} 19:26:02 INFO - Return code: 0 19:26:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:26:02 INFO - # TBPL SUCCESS # 19:26:02 INFO - Running post-action listener: _resource_record_post_action 19:26:02 INFO - Running post-run listener: _resource_record_post_run 19:26:03 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 566493184; Read time: 0; Write time: 643552 19:26:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244109312; Read time: 0; Write time: 352076 19:26:03 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 318177280; Read time: 0; Write time: 290928 19:26:03 INFO - Running post-run listener: _upload_blobber_files 19:26:03 INFO - Blob upload gear active. 19:26:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:03 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 19:26:03 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:26:03 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:26:04 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:05 INFO - (blobuploader) - INFO - Done attempting. 19:26:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:26:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:26:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:06 INFO - (blobuploader) - INFO - Done attempting. 19:26:06 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:06 INFO - Return code: 0 19:26:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/033462dec4d8163e3ffacaae9d570d788cfa173d1aa6214815e82cf4d778e2e0232dd6acab2f1c61c5846fc90754f47f7572655cf36d4c873659302ed754f22d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/46e6f02891898bc3a301ada5a9ab3484baebcb2331dbbe7d7804f83336602fb7f4c802939b803b08572dbdc303493843c534fcd53723c39092deee3cd59a8279"} 19:26:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:06 INFO - Contents: 19:26:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/033462dec4d8163e3ffacaae9d570d788cfa173d1aa6214815e82cf4d778e2e0232dd6acab2f1c61c5846fc90754f47f7572655cf36d4c873659302ed754f22d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/46e6f02891898bc3a301ada5a9ab3484baebcb2331dbbe7d7804f83336602fb7f4c802939b803b08572dbdc303493843c534fcd53723c39092deee3cd59a8279"} 19:26:06 INFO - Copying logs to upload dir... 19:26:06 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.375192 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 19:26:05.630686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 19:26:05.634111) ========= 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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/033462dec4d8163e3ffacaae9d570d788cfa173d1aa6214815e82cf4d778e2e0232dd6acab2f1c61c5846fc90754f47f7572655cf36d4c873659302ed754f22d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/46e6f02891898bc3a301ada5a9ab3484baebcb2331dbbe7d7804f83336602fb7f4c802939b803b08572dbdc303493843c534fcd53723c39092deee3cd59a8279"} build_url:https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/CQsI5r7tSVyu7Q0UN2mEvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/033462dec4d8163e3ffacaae9d570d788cfa173d1aa6214815e82cf4d778e2e0232dd6acab2f1c61c5846fc90754f47f7572655cf36d4c873659302ed754f22d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/46e6f02891898bc3a301ada5a9ab3484baebcb2331dbbe7d7804f83336602fb7f4c802939b803b08572dbdc303493843c534fcd53723c39092deee3cd59a8279"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 19:26:05.659064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:26:05.659450) ========= 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=0274524eba3bdaad075c2247000001d4-1452128098.212420-1382496270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 19:26:05.742548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 19:26:05.742868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 19:26:05.743193) ========= ========= Total master_lag: 0.22 =========